Daily Usenet report: Jun 8 04:15:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jun 8 09:40:31 newsfeed nnrpd[27526]: SERVER perl filter not defined
Jun 8 09:44:31 newsfeed nnrpd[27721]: SERVER perl filter not defined
Jun 8 21:25:05 newsfeed nnrpd[19492]: SERVER perl filter not defined
Jun 8 21:25:59 newsfeed nnrpd[19494]: SERVER perl filter not defined
Jun 8 21:44:03 newsfeed nnrpd[20128]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2286478	98.7%	259.5 MB	98.3%
innd	19963	0.9%	3.3 MB	1.2%
nnrpd	7167	0.3%	768.1 KB	0.3%
innfeed	2537	0.1%	378.9 KB	0.1%
TOTAL: 4	2316145	100.0%	263.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2280585	97.9%
Negative hits	33656	1.4%
Positive hits	14855	0.6%
Cache misses	105	0.0%
TOTAL: 4	2329201	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.097	0.0%	268	0.000	4.093	158.000
article cleanup	00:00:29.309	0.0%	2284788	0.005	0.013	0.025
article logging	00:01:10.246	0.1%	2284912	0.017	0.031	0.291
article parse	01:00:27.389	4.2%	115838800	0.021	0.031	0.071
article write	00:24:02.201	1.7%	2279732	0.314	0.633	2.386
artlog/artcncl	00:00:00.003	0.0%	262	0.000	0.011	0.500
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:18.463	0.2%	130638931	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.257	0.0%	216	0.000	1.190	58.000
hishave/artcncl	00:00:00.039	0.0%	268	0.000	0.146	6.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:13:04.115	0.9%	2329466	0.029	0.337	10.573
history sync	00:00:00.020	0.0%	291	0.000	0.069	2.000
history write	00:18:26.787	1.3%	2280962	0.216	0.485	11.338
hiswrite/artcncl	00:00:00.023	0.0%	52	0.000	0.442	8.000
idle	14:52:46.214	62.0%	89395959	0.442	0.599	2.414
nntp read	00:52:38.361	3.7%	114115915	0.017	0.028	0.066
overview write	00:00:14.307	0.0%	2279732	0.001	0.006	0.027
perl filter	05:32:28.359	23.1%	2280962	5.287	8.746	12.342
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:28.018	0.3%	4607122	0.035	0.058	0.620
TOTAL: 23:59:10.247	23:22:35.208	97.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.210	0.0%	47689	0.000	0.004	0.167
article prepare	00:00:00.009	0.0%	39060	0.000	0.000	0.125
article read	00:00:01.013	0.0%	9484	0.000	0.107	1.000
backlog stats	00:00:00.492	0.0%	273206	0.000	0.002	1.226
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.425	0.0%	164829	0.000	0.015	1.126
data write	00:00:08.440	0.0%	117759	0.000	0.072	8.785
idle	23:59:52.879	100.0%	273206	66.666	316.219	2935.000
status file	00:00:00.853	0.0%	235	0.000	3.630	41.000
TOTAL: 24:00:13.836	24:00:06.321	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	07:38:12.141	99.9%	60005	0.000	458.164	450015.250
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.527	0.0%	122511	0.000	0.021	1.943
readart	00:00:10.215	0.0%	750	0.000	13.620	53.935
TOTAL: 07:38:46.481	07:38:24.883	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	1069	2281817	2276264	815	4738	99%	262:10:43
2	news.nask.pl	2	14484	4632	9584	268	31%	23:14:39
3	news.icm.edu.pl	42	328	37	247	44	11%	17:19:51
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		1119	2296634	2280938	10646	5050	99%	302:45:13

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	777.1 GB	13.6 MB	164.9 MB	777.3 GB	99%	357.3 KB
2	news.nask.pl	18.8 MB	580.2 KB	676.9 KB	20.0 MB	93%	4.2 KB
3	news.icm.edu.pl	944.1 KB	118.9 KB	866.5 KB	1.9 MB	48%	23.8 KB
4	localhost	7.3 KB	0.0 KB	0.0 KB	7.3 KB	100%	1.5 KB
TOTAL: 4		777.1 GB	14.3 MB	166.4 MB	777.3 GB	99%	356.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 8 04:15:02 - 04:59:59	61702	2.7%	22.87	21.7 GB	2.8%	8452.91
Jun 8 05:00:00 - 05:59:59	87032	3.8%	24.18	30.6 GB	3.9%	8907.52
Jun 8 06:00:00 - 06:59:59	91285	4.0%	25.36	32.8 GB	4.2%	9553.04
Jun 8 07:00:00 - 07:59:59	108714	4.8%	30.20	37.0 GB	4.8%	10765.15
Jun 8 08:00:00 - 08:59:59	102598	4.5%	28.50	37.2 GB	4.8%	10846.98
Jun 8 09:00:00 - 09:59:59	100893	4.4%	28.03	32.5 GB	4.2%	9456.62
Jun 8 10:00:00 - 10:59:59	85268	3.7%	23.69	28.5 GB	3.7%	8294.46
Jun 8 11:00:00 - 11:59:59	87709	3.8%	24.36	29.3 GB	3.8%	8532.09
Jun 8 12:00:00 - 12:59:59	95045	4.2%	26.40	32.7 GB	4.2%	9528.50
Jun 8 13:00:00 - 13:59:59	101789	4.5%	28.27	34.9 GB	4.5%	10167.93
Jun 8 14:00:00 - 14:59:59	102948	4.5%	28.60	34.9 GB	4.5%	10155.27
Jun 8 15:00:00 - 15:59:59	100908	4.4%	28.03	35.4 GB	4.6%	10299.54
Jun 8 16:00:00 - 16:59:59	98634	4.3%	27.40	34.7 GB	4.5%	10110.85
Jun 8 17:00:00 - 17:59:59	92355	4.0%	25.65	31.1 GB	4.0%	9067.59
Jun 8 18:00:00 - 18:59:59	92668	4.1%	25.74	31.6 GB	4.1%	9199.67
Jun 8 19:00:00 - 19:59:59	98750	4.3%	27.43	34.1 GB	4.4%	9920.21
Jun 8 20:00:00 - 20:59:59	101610	4.5%	28.23	34.8 GB	4.5%	10144.80
Jun 8 21:00:00 - 21:59:59	107223	4.7%	29.78	35.1 GB	4.5%	10214.54
Jun 8 22:00:00 - 22:59:59	105419	4.6%	29.28	32.4 GB	4.2%	9428.86
Jun 8 23:00:00 - 23:59:59	102145	4.5%	28.37	32.0 GB	4.1%	9310.99
Jun 9 00:00:00 - 00:59:59	88520	3.9%	24.59	29.0 GB	3.7%	8436.73
Jun 9 01:00:00 - 01:59:59	74427	3.3%	20.67	27.2 GB	3.5%	7927.19
Jun 9 02:00:00 - 02:59:59	81258	3.6%	22.57	28.3 GB	3.6%	8248.57
Jun 9 03:00:00 - 03:59:59	89252	3.9%	24.79	30.9 GB	4.0%	9002.69
Jun 9 04:00:00 - 04:15:02	22884	1.0%	25.37	8.5 GB	1.1%	9882.30
TOTAL: 24:00:00	2281036	100.0%	26.40	777.0 GB	100.0%	9430.45

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4841	218	3589	1	1033
2	news.nask.pl	293	25	235	8	25
3	news.icm.edu.pl	46	0	2	0	44
TOTAL: 3		5180	243	3826	9	1102

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	84
it.tlc.cellulari.android	43
comp.mobile.ipad	23
it.comp.os.win.windows8	20
it.comp.os.win.windows7	20
comp.sys.raspberry-pi	13
hr.alt.cellular.gsm.iphone	7
comp.mobile.android	6
alt.sex.telephone.alt.sex.services	4
de.comm.software.mailreader	4
de.rec.sf.startrek	4
hr.ponuda.hardver.komponente	4
hr.alt.cellular.gsm.android	3
de.comp.office-pakete.ms-office.excel	3
alt.sex.telephones	3
comp.sys.mac.vintage	1
de.comp.lang.vbclassic	1
TOTAL: 17	243

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

Groups	Count
pl.sci.matematyka	8
pl.sci.historia	1
TOTAL: 2	9

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	919
EMP (md5)	45
HTML post	10
Attached HTML file	2
Too many newsgroups	1
Scoring filter (9)	1
TOTAL: 6	978

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	60217	3400	43806	483	0	0	5%	23:59:45
2	icm	41913	1043	25408	4737	2	18	2%	23:54:05
3	poznan	7089	97	4660	7	0	0	1%	23:56:36
4	nask	0	0	0	0	0	11439	0%	24:00:01
5	okapi	0	0	0	0	0	2362	0%	24:00:01
TOTAL: 5		109219	4540	73874	5227	2	13819	4%	119:50:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	10.9 MB	5.5 MB	16.4 MB	0.2 KB/s	4.3 KB	23:59:45
2	poznan	4.1 MB	589.9 KB	4.7 MB	0.1 KB/s	46.5 KB	23:56:36
3	icm	4.1 MB	867.0 MB	871.0 MB	10.4 KB/s	154.3 KB	23:54:05
4	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		19.1 MB	873.0 MB	892.2 MB	2.1 KB/s	93.5 KB	119:50:28

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	dmcs2.p.lodz.pl	7	331	723.6 KB	6	0	02:19:53
2	pc-skrzep2.cm.p.lodz.pl	288	328	539.1 KB	288	0	00:00:09
3	web.man.lodz.pl	288	44	45.7 KB	19	0	00:00:35
4	lze200.lze.lodz.pl	3	23	41.6 KB	4	0	01:04:54
5	pc-212-51-218-225.p.lodz.pl	4	22	42.6 KB	7	0	01:36:53
6	89-68-226-130.dynamic.chello.pl	1	2	3.0 KB	2	0	00:32:58
7	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 7		596	750	1.4 MB	326	5	07:38:45

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.p.lodz.pl	11	353	766.2 KB	13	0	03:56:47
2	*.cm.p.lodz.pl	288	328	539.1 KB	288	0	00:00:09
3	*.man.lodz.pl	677	44	45.7 KB	19	5	00:00:39
4	*.lze.lodz.pl	3	23	41.6 KB	4	0	01:04:54
5	*.dynamic.chello.pl	1	2	3.0 KB	2	0	00:32:58
6	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:05
7	*.toya.net.pl	55	0	0.0 KB	0	0	00:00:02
TOTAL: 7		1037	750	1.4 MB	326	5	07:38:45

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
dmcs2.p.lodz.pl	0.067	0.329	02:19:53
185.48.195.96	3.041	4.506	02:03:06
pc-212-51-218-225.p.lodz.pl	0.017	0.074	01:36:53
lze200.lze.lodz.pl	0.010	0.084	01:04:54
89-68-226-130.dynamic.chello.pl	0.035	0.015	00:32:58
web.man.lodz.pl	1.117	3.985	00:00:35
pc-skrzep2.cm.p.lodz.pl	1.062	4.739	00:00:09
host227.elsnet.pl	0.007	0.022	00:00:05
mon.man.lodz.pl	1.072	4.080	00:00:03
staticline41435.toya.net.pl	0.241	0.862	00:00:02
david.man.lodz.pl	0.374	1.490	00:00:00
isvcs01.man.lodz.pl	0.037	0.090	00:00:00
?	0.006	0.006	00:00:00
TOTAL: 13	7.086	20.282	07:38:45

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	55
host227.elsnet.pl	2
TOTAL: 4	441

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
lze200.lze.lodz.pl	2	0
pc-212-51-218-225.p.lodz.pl	2	0
dmcs2.p.lodz.pl	2	0
89-68-226-130.dynamic.chello.pl	1	0
TOTAL: 4	7	0

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	420	56.0%
2	lodman	330	44.0%
TOTAL: 2		750	100.0%

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

Newsgroup		Count
1	lodman.info	330
2	pl.misc.elektronika	230
3	pl.misc.kolej	123
4	pl.comp.pecet	38
5	pl.comp.os.ms-windows.winnt	17
6	pl.misc.telefonia.gsm	9
7	pl.rec.kuchnia	3
TOTAL: 7		750

Daily Usenet report

Jun 8 04:15:02 -- Jun 9 04:15:02