Daily Usenet report: Jan 25 04:15:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jan 25 13:24:47 newsfeed nnrpd[13861]: SERVER perl filter not defined
Jan 25 15:22:48 newsfeed innfeed[2136]: nask:0 connect: Network is unreachable
Jan 25 15:22:48 newsfeed innfeed[2136]: icm:0 connect: Network is unreachable

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1241854	97.9%	141.6 MB	97.4%
innd	13407	1.1%	2.2 MB	1.5%
nnrpd	6927	0.5%	704.5 KB	0.5%
innfeed	6641	0.5%	971.3 KB	0.7%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	1268830	100.0%	145.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1213845	97.1%
Negative hits	20241	1.6%
Positive hits	15737	1.3%
Cache misses	152	0.0%
TOTAL: 4	1249975	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:08.117	0.0%	354	0.000	22.929	504.000
article cleanup	00:00:19.128	0.0%	1217948	0.000	0.016	0.068
article logging	00:00:33.841	0.0%	1240817	0.000	0.027	0.229
article parse	00:42:25.705	2.9%	99764497	0.007	0.026	0.041
article write	00:10:21.757	0.7%	1212832	0.130	0.513	10.536
artlog/artcncl	00:00:00.002	0.0%	294	0.000	0.007	0.500
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:02:05.297	0.1%	106931890	0.000	0.001	0.023
hisgrep/artcncl	00:00:01.787	0.0%	344	0.000	5.195	287.000
hishave/artcncl	00:00:01.263	0.0%	354	0.000	3.568	75.667
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:39:18.769	6.9%	1250348	0.010	4.766	22.039
history sync	00:00:00.026	0.0%	348	0.000	0.075	2.000
history write	02:19:25.120	9.7%	1214417	2.307	6.888	30.823
hiswrite/artcncl	00:00:00.059	0.0%	10	0.000	5.900	19.000
idle	15:24:14.749	64.2%	71972560	0.330	0.770	17.713
nntp read	00:39:52.508	2.8%	98800021	0.010	0.024	0.054
overview write	00:00:07.817	0.0%	1212832	0.000	0.006	0.037
perl filter	02:36:19.421	10.9%	1214415	3.364	7.723	10.793
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:39.684	0.2%	2455293	0.016	0.065	0.130
TOTAL: 23:59:19.289	23:37:55.050	98.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.106	0.0%	29753	0.000	0.004	0.167
article prepare	00:00:00.006	0.0%	13800	0.000	0.000	0.250
article read	00:00:00.406	0.0%	3414	0.000	0.119	1.000
backlog stats	00:00:00.094	0.0%	176925	0.000	0.001	0.020
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.156	0.0%	116381	0.000	0.010	1.000
data write	00:00:04.402	0.0%	89679	0.000	0.049	20.000
idle	23:59:47.923	100.0%	176925	0.000	488.274	21579.000
status file	00:00:01.301	0.0%	235	0.000	5.536	133.500
TOTAL: 23:59:59.766	23:59:55.394	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.058	0.0%	16	2.000	3.625	5.250
idle	02:10:23.243	99.7%	7340	0.000	1065.837	600092.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.398	0.0%	16331	0.000	0.024	2.778
readart	00:00:00.045	0.0%	350	0.000	0.129	11.000
TOTAL: 02:10:44.136	02:10:23.744	99.7%	-	-	-	-

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	600	1214454	1209982	236	4236	99%	255:20:51
2	news.nask.pl	4	15223	3144	11324	755	20%	23:36:02
3	news.icm.edu.pl	43	355	64	208	83	18%	18:39:02
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		649	1230033	1213191	11768	5074	98%	297:35:55

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	325.9 GB	78.4 MB	236.7 MB	326.2 GB	99%	281.7 KB
2	news.nask.pl	11.7 MB	2.0 MB	2.1 MB	15.8 MB	74%	4.1 KB
3	news.icm.edu.pl	2.8 MB	181.2 KB	5.5 MB	8.4 MB	33%	58.6 KB
4	localhost	0.7 KB	0.0 KB	0.0 KB	0.7 KB	100%	0.7 KB
TOTAL: 4		325.9 GB	80.6 MB	244.2 MB	326.3 GB	99%	280.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 25 04:15:01 - 04:59:59	9370	0.8%	3.47	2.3 GB	0.7%	892.16
Jan 25 05:00:00 - 05:59:59	7795	0.6%	2.17	1.8 GB	0.6%	528.60
Jan 25 06:00:00 - 06:59:59	7360	0.6%	2.04	1.2 GB	0.4%	335.63
Jan 25 07:00:00 - 07:59:59	8982	0.7%	2.50	1.5 GB	0.5%	430.26
Jan 25 08:00:00 - 08:59:59	17855	1.5%	4.96	5.2 GB	1.6%	1515.04
Jan 25 09:00:00 - 09:59:59	39723	3.3%	11.03	13.2 GB	4.0%	3830.79
Jan 25 10:00:00 - 10:59:59	25949	2.1%	7.21	7.0 GB	2.2%	2042.40
Jan 25 11:00:00 - 11:59:59	31261	2.6%	8.68	8.3 GB	2.6%	2426.39
Jan 25 12:00:00 - 12:59:59	40838	3.4%	11.34	11.7 GB	3.6%	3415.94
Jan 25 13:00:00 - 13:59:59	43009	3.5%	11.95	12.5 GB	3.8%	3642.72
Jan 25 14:00:00 - 14:59:59	44943	3.7%	12.48	11.8 GB	3.6%	3446.08
Jan 25 15:00:00 - 15:59:59	47080	3.9%	13.08	12.4 GB	3.8%	3615.98
Jan 25 16:00:00 - 16:59:59	57131	4.7%	15.87	15.7 GB	4.8%	4565.61
Jan 25 17:00:00 - 17:59:59	59826	4.9%	16.62	16.7 GB	5.1%	4873.08
Jan 25 18:00:00 - 18:59:59	80511	6.6%	22.36	21.2 GB	6.5%	6164.38
Jan 25 19:00:00 - 19:59:59	84908	7.0%	23.59	22.6 GB	6.9%	6579.53
Jan 25 20:00:00 - 20:59:59	80556	6.6%	22.38	20.9 GB	6.4%	6086.76
Jan 25 21:00:00 - 21:59:59	82479	6.8%	22.91	22.0 GB	6.7%	6403.44
Jan 25 22:00:00 - 22:59:59	77676	6.4%	21.58	20.4 GB	6.3%	5941.50
Jan 25 23:00:00 - 23:59:59	91385	7.5%	25.38	24.4 GB	7.5%	7099.79
Jan 26 00:00:00 - 00:59:59	64866	5.3%	18.02	17.0 GB	5.2%	4962.07
Jan 26 01:00:00 - 01:59:59	66812	5.5%	18.56	17.2 GB	5.3%	4997.43
Jan 26 02:00:00 - 02:59:59	71718	5.9%	19.92	19.7 GB	6.0%	5728.69
Jan 26 03:00:00 - 03:59:59	52302	4.3%	14.53	14.0 GB	4.3%	4082.19
Jan 26 04:00:00 - 04:15:04	19222	1.6%	21.26	5.5 GB	1.7%	6358.75
TOTAL: 24:00:03	1213557	100.0%	14.05	326.1 GB	100.0%	3957.36

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	27112	190	2749	1	24172
2	news.nask.pl	822	19	782	10	11
3	news.icm.edu.pl	72	0	4	0	68
TOTAL: 3		28006	209	3535	11	24251

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	75
comp.mobile.android	37
de.rec.sf.startrek	29
it.comp.os.win.windows7	23
comp.sys.raspberry-pi	11
it.tlc.cellulari.android	6
hr.rec.sport.rukomet	4
hr.ponuda.hardver.komponente	4
hr.alt.cellular.gsm.android	3
comp.mobile.ipad	3
it.comp.os.win.windows8	3
de.comp.lang.vbclassic	2
uk.current-events.charlie-hebdo	2
uk.rec.cycling.moderated	2
alt.sex.telephones	1
hr.ponuda.hardver.periferije	1
hr.rec.glazba.hifi	1
de.comm.software.mailreader	1
de.comp.lang.perl	1
TOTAL: 19	209

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	1297
EMP (md5)	66
Scoring filter (8)	1
TOTAL: 3	1364

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	30022	1170	28141	145	0	3%	23:50:02
2	icm	31730	218	24854	1804	83	0%	23:59:42
3	nask	18331	23	13085	37	23	0%	23:56:24
4	poznan	4002	21	2963	13	0	0%	23:50:36
5	okapi	0	0	0	0	2301	0%	23:50:04
TOTAL: 5		84085	1432	69043	1999	2407	1%	119:26:48

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	13.6 MB	517.7 MB	531.3 MB	6.3 KB/s	269.1 KB	23:59:42
2	panorama	4.1 MB	664.4 KB	4.7 MB	0.1 KB/s	3.7 KB	23:50:02
3	nask	797.4 KB	22.8 MB	23.6 MB	0.3 KB/s	402.8 KB	23:56:24
4	poznan	64.9 KB	44.5 KB	109.5 KB	0.0 KB/s	3.2 KB	23:50:36
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:04
TOTAL: 5		18.5 MB	541.2 MB	559.8 MB	1.3 KB/s	167.1 KB	119:26:48

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	288	456.8 KB	288	0	00:00:06
2	web.man.lodz.pl	287	62	58.3 KB	28	0	00:00:25
3	wireless.ics.p.lodz.pl	1	0	0.0 KB	0	1	00:30:00
TOTAL: 3		576	350	515.0 KB	316	1	02:10:43

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	288	456.8 KB	288	0	00:00:06
2	*.man.lodz.pl	671	62	58.3 KB	28	0	00:00:31
3	*.dynamic.mm.pl	1	0	0.0 KB	0	0	00:11:32
4	*.jmdi.pl	1	0	0.0 KB	0	0	00:00:31
5	unresolved	4	0	0.0 KB	0	0	00:08:52
6	*.neoplus.adsl.tpnet.pl	6	0	0.0 KB	0	0	01:19:04
7	*.ics.p.lodz.pl	1	0	0.0 KB	0	1	00:30:00
8	*.toya.net.pl	23	0	0.0 KB	0	0	00:00:04
TOTAL: 8		995	350	515.0 KB	316	1	02:10:43

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
bpw42.neoplus.adsl.tpnet.pl	0.018	0.041	01:12:39
wireless.ics.p.lodz.pl	0.009	0.019	00:30:00
host-37-190-188-160.dynamic.mm.pl	0.026	0.017	00:11:32
185.48.194.196	0.188	0.221	00:08:52
amh22.neoplus.adsl.tpnet.pl	0.083	0.047	00:06:25
host-80-238-112-56.jmdi.pl	0.012	0.009	00:00:31
web.man.lodz.pl	0.996	3.813	00:00:25
pc-skrzep2.cm.p.lodz.pl	0.849	3.206	00:00:06
mon.man.lodz.pl	1.001	3.613	00:00:05
staticline41435.toya.net.pl	0.082	0.208	00:00:04
david.man.lodz.pl	0.333	1.195	00:00:01
TOTAL: 11	3.597	12.389	02:10:43

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	23
185.48.194.196	4
bpw42.neoplus.adsl.tpnet.pl	4
amh22.neoplus.adsl.tpnet.pl	2
host-37-190-188-160.dynamic.mm.pl	1
host-80-238-112-56.jmdi.pl	1
TOTAL: 8	419

NNRP client timeouts [Top 20]:

System	Conn	Peer
bpw42.neoplus.adsl.tpnet.pl	2	0
wireless.ics.p.lodz.pl	1	0
TOTAL: 2	3	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	288	82.3%
2	pl	62	17.7%
TOTAL: 2		350	100.0%

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

Newsgroup		Count
1	lodman.info	288
2	pl.comp.pecet	50
3	pl.comp.os.ms-windows.winnt	12
TOTAL: 3		350

Daily Usenet report

Jan 25 04:15:01 -- Jan 26 04:15:04