Daily Usenet report: Mar 10 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Mar 10 08:36:11 newsfeed nnrpd[30375]: SERVER perl filter not defined
Mar 10 09:26:37 newsfeed overchan[2531]: input line too long, skipping
Mar 10 14:08:38 newsfeed nnrpd[8932]: SERVER perl filter not defined
Mar 10 19:36:56 newsfeed nnrpd[19833]: SERVER perl filter not defined
Mar 11 00:07:09 newsfeed nnrpd[28875]: SERVER perl filter not defined
Mar 11 03:11:20 newsfeed overchan[2531]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	811278	97.2%	96.0 MB	96.7%
innd	9556	1.1%	1.6 MB	1.6%
nnrpd	7322	0.9%	761.7 KB	0.7%
innfeed	6408	0.8%	906.4 KB	0.9%
overchan	2	0.0%	0.3 KB	0.0%
TOTAL: 5	834566	100.0%	99.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	807476	95.8%
Positive hits	18128	2.2%
Negative hits	16843	2.0%
Cache misses	314	0.0%
TOTAL: 4	842761	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.331	0.0%	289	0.000	14.986	316.000
article cleanup	00:00:11.234	0.0%	811149	0.000	0.014	0.052
article logging	00:00:19.724	0.0%	811304	0.000	0.024	0.208
article parse	00:18:46.583	1.3%	53872115	0.009	0.021	0.057
article write	00:05:24.120	0.4%	808183	0.155	0.401	5.245
artlog/artcncl	00:00:00.007	0.0%	276	0.000	0.025	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:58.626	0.1%	58342092	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.665	0.0%	248	0.000	2.681	51.000
hishave/artcncl	00:00:00.152	0.0%	289	0.000	0.526	13.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:27:49.897	1.9%	844032	0.008	1.978	8.947
history sync	00:00:00.023	0.0%	475	0.000	0.048	1.000
history write	01:19:36.558	5.5%	808867	0.066	5.905	18.772
hiswrite/artcncl	00:00:00.116	0.0%	41	0.000	2.829	14.000
idle	19:42:52.956	82.1%	45363371	0.414	1.565	9.233
nntp read	00:19:33.683	1.4%	53317401	0.014	0.022	0.041
overview write	00:00:05.193	0.0%	808183	0.000	0.006	0.040
perl filter	01:22:34.348	5.7%	808867	2.245	6.125	10.567
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:01:40.990	0.1%	1655567	0.027	0.061	0.148
TOTAL: 24:00:12.965	23:39:59.206	98.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.151	0.0%	39549	0.000	0.004	0.167
article prepare	00:00:00.003	0.0%	10568	0.000	0.000	0.125
article read	00:00:00.112	0.0%	2588	0.000	0.043	1.000
backlog stats	00:00:00.111	0.0%	233310	0.000	0.000	0.045
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.351	0.0%	154685	0.000	0.009	0.071
data write	00:00:03.289	0.0%	115803	0.000	0.028	9.000
idle	24:00:20.847	100.0%	233310	0.000	370.412	11056.000
status file	00:00:02.000	0.0%	199	0.000	10.050	242.500
TOTAL: 24:00:32.908	24:00:27.864	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.303	0.0%	38	1.769	7.974	21.417
idle	11:15:24.013	99.9%	208083	0.000	194.749	301883.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:05.611	0.0%	418167	0.000	0.013	1.111
readart	00:00:01.720	0.0%	476	0.000	3.613	244.000
TOTAL: 11:15:58.068	11:15:31.647	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	260	808108	805255	320	2533	99%	140:15:04
2	news.nask.pl	2	18425	2484	15507	434	13%	24:18:58
3	news.icm.edu.pl	43	329	64	247	18	19%	17:27:26
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		310	826866	807807	16074	2985	97%	182:01:28

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	151.1 GB	16.1 MB	32.2 MB	151.1 GB	99%	196.2 KB
2	news.nask.pl	13.5 MB	1.3 MB	1.4 MB	16.2 MB	83%	5.7 KB
3	news.icm.edu.pl	5.2 MB	93.8 KB	529.6 KB	5.8 MB	89%	72.9 KB
4	localhost	6.3 KB	0.0 KB	0.0 KB	6.3 KB	100%	1.6 KB
TOTAL: 4		151.1 GB	17.5 MB	34.1 MB	151.2 GB	99%	195.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 10 04:15:02 - 04:59:59	52833	6.5%	19.58	14.7 GB	9.7%	5704.00
Mar 10 05:00:00 - 05:59:59	12588	1.6%	3.50	2.0 GB	1.3%	587.16
Mar 10 06:00:00 - 06:59:59	12260	1.5%	3.41	1.8 GB	1.2%	521.42
Mar 10 07:00:00 - 07:59:59	12921	1.6%	3.59	2.0 GB	1.3%	575.43
Mar 10 08:00:00 - 08:59:59	12987	1.6%	3.61	1.8 GB	1.2%	537.91
Mar 10 09:00:00 - 09:59:59	12734	1.6%	3.54	1.7 GB	1.1%	488.56
Mar 10 10:00:00 - 10:59:59	15898	2.0%	4.42	1.8 GB	1.2%	527.95
Mar 10 11:00:00 - 11:59:59	13764	1.7%	3.82	1.8 GB	1.2%	534.61
Mar 10 12:00:00 - 12:59:59	13192	1.6%	3.66	2.1 GB	1.4%	606.06
Mar 10 13:00:00 - 13:59:59	13626	1.7%	3.79	2.1 GB	1.4%	611.68
Mar 10 14:00:00 - 14:59:59	11662	1.4%	3.24	1.9 GB	1.2%	545.65
Mar 10 15:00:00 - 15:59:59	11758	1.5%	3.27	1.7 GB	1.1%	503.52
Mar 10 16:00:00 - 16:59:59	12059	1.5%	3.35	1.9 GB	1.3%	565.19
Mar 10 17:00:00 - 17:59:59	10565	1.3%	2.93	1.6 GB	1.1%	477.94
Mar 10 18:00:00 - 18:59:59	11606	1.4%	3.22	1.7 GB	1.1%	482.41
Mar 10 19:00:00 - 19:59:59	54755	6.8%	15.21	6.8 GB	4.5%	1976.87
Mar 10 20:00:00 - 20:59:59	59613	7.4%	16.56	7.4 GB	4.9%	2142.06
Mar 10 21:00:00 - 21:59:59	57533	7.1%	15.98	7.2 GB	4.8%	2090.17
Mar 10 22:00:00 - 22:59:59	54608	6.8%	15.17	6.6 GB	4.4%	1929.26
Mar 10 23:00:00 - 23:59:59	63837	7.9%	17.73	8.0 GB	5.3%	2320.29
Mar 11 00:00:00 - 00:59:59	62360	7.7%	17.32	13.6 GB	9.0%	3957.15
Mar 11 01:00:00 - 01:59:59	75156	9.3%	20.88	20.0 GB	13.2%	5814.31
Mar 11 02:00:00 - 02:59:59	65910	8.2%	18.31	17.8 GB	11.8%	5193.94
Mar 11 03:00:00 - 03:59:59	61481	7.6%	17.08	16.7 GB	11.1%	4869.66
Mar 11 04:00:00 - 04:15:02	22175	2.7%	24.58	6.4 GB	4.2%	7445.22
TOTAL: 24:00:00	807881	100.0%	9.35	151.1 GB	100.0%	1833.31

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	2678	343	1901	6	428
2	news.nask.pl	425	15	378	5	27
3	news.icm.edu.pl	18	0	3	1	14
TOTAL: 3		3121	358	2282	12	469

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	253
it.tlc.cellulari.android	24
comp.sys.raspberry-pi	21
comp.mobile.android	18
alt.sex.telephones	7
uk.rec.cycling.moderated	7
it.comp.os.win.windows8	6
comp.mobile.ipad	4
de.comp.lang.php	3
hr.ponuda.hardver.periferije	3
it.comp.os.win.windows7	3
hr.alt.cellular.gsm.iphone	3
de.comp.office-pakete.ms-office.excel	2
de.comp.lang.vbclassic	2
de.comp.lang.perl	1
hr.ponuda.hardver.komponente	1
TOTAL: 16	358

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

Groups	Count
pl.sci.historia	7
pl.praca.oferowana	4
bit.listserv.catholic	1
TOTAL: 3	12

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	281
EMP (md5)	26
HTML post	4
Scoring filter (8)	2
Scoring filter (9)	1
TOTAL: 5	314

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	39885	1149	37819	163	0	2%	23:52:46
2	icm	48193	438	36579	620	292	0%	23:59:43
3	nask	24683	243	16509	4	48	0%	24:01:44
4	poznan	3094	14	2175	3	0	0%	24:01:01
5	okapi	0	0	0	0	2559	0%	24:00:02
TOTAL: 5		115855	1844	93082	790	2899	1%	119:55:16

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	5.5 MB	593.1 KB	6.1 MB	0.1 KB/s	4.7 KB	23:52:46
2	nask	2.4 MB	28.2 KB	2.4 MB	0.0 KB/s	9.9 KB	24:01:44
3	icm	1.3 MB	70.0 MB	71.4 MB	0.8 KB/s	69.1 KB	23:59:43
4	poznan	155.3 KB	6.4 KB	161.7 KB	0.0 KB/s	9.5 KB	24:01:01
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		9.3 MB	70.7 MB	80.0 MB	0.2 KB/s	31.1 KB	119:55:16

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	288	336	692.0 KB	288	0	00:00:09
2	pc-212-51-218-225.p.lodz.pl	8	75	149.5 KB	10	0	02:52:29
3	web.man.lodz.pl	288	36	264.8 KB	18	0	00:00:21
4	lze200.lze.lodz.pl	10	29	52.9 KB	7	0	01:04:31
5	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 5		598	476	1.1 MB	323	4	11:15:57

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	336	692.0 KB	288	0	00:00:09
2	*.p.lodz.pl	8	75	149.5 KB	10	0	02:52:29
3	*.man.lodz.pl	676	36	264.8 KB	18	4	00:00:26
4	*.lze.lodz.pl	10	29	52.9 KB	7	0	01:04:31
5	*.sieradz.vectranet.pl	1	0	0.0 KB	0	0	00:00:17
6	unresolved	6	0	0.0 KB	0	0	07:17:53
7	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:05
8	*.toya.net.pl	70	0	0.0 KB	0	0	00:00:04
TOTAL: 8		1061	476	1.1 MB	323	4	11:15:57

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.77	6.837	10.942	06:32:05
pc-212-51-218-225.p.lodz.pl	0.040	0.113	02:52:29
lze200.lze.lodz.pl	0.038	0.141	01:04:31
212.191.87.58	0.009	0.037	00:45:48
web.man.lodz.pl	1.007	3.611	00:00:21
088156077175.sieradz.vectranet.pl	0.039	0.008	00:00:17
pc-skrzep2.cm.p.lodz.pl	1.049	3.643	00:00:09
host227.elsnet.pl	0.010	0.021	00:00:05
staticline41435.toya.net.pl	0.252	0.904	00:00:04
mon.man.lodz.pl	1.031	3.420	00:00:03
david.man.lodz.pl	0.349	1.152	00:00:01
isvcs01.man.lodz.pl	0.018	0.063	00:00:00
?	0.000	0.013	00:00:00
TOTAL: 13	10.679	24.068	11:15:57

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	70
185.48.193.77	4
host227.elsnet.pl	2
212.191.87.58	2
088156077175.sieradz.vectranet.pl	1
TOTAL: 7	463

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	6	0
pc-212-51-218-225.p.lodz.pl	3	0
TOTAL: 2	9	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	336	70.6%
2	pl	140	29.4%
TOTAL: 2		476	100.0%

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

Newsgroup		Count
1	lodman.info	336
2	pl.misc.elektronika	48
3	pl.comp.os.ms-windows.winnt	33
4	pl.misc.kolej	27
5	pl.comp.pecet	11
6	pl.rec.kuchnia	10
7	pl.misc.telefonia.gsm	5
8	pl.comp.os.linux	4
9	pl.internet.polip	2
TOTAL: 9		476

Daily Usenet report

Mar 10 04:15:02 -- Mar 11 04:15:02