Daily Usenet report: Oct 9 04:15:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Oct 9 04:40:41 newsfeed nnrpd[28681]: SERVER perl filter not defined
Oct 9 07:20:16 newsfeed nnrpd[2708]: SERVER perl filter not defined
Oct 9 08:52:15 newsfeed nnrpd[5827]: SERVER perl filter not defined
Oct 9 11:10:49 newsfeed nnrpd[10646]: SERVER perl filter not defined
Oct 9 12:05:27 newsfeed nnrpd[12473]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2275307	97.2%	261.1 MB	96.8%
innfeed	41629	1.8%	4.9 MB	1.8%
innd	18593	0.8%	3.2 MB	1.2%
nnrpd	5129	0.2%	551.7 KB	0.2%
TOTAL: 4	2340658	100.0%	269.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2268016	98.1%
Negative hits	26984	1.2%
Positive hits	15990	0.7%
Cache misses	97	0.0%
TOTAL: 4	2311087	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.127	0.0%	209	0.000	19.746	1145.000
article cleanup	00:00:27.862	0.0%	2273499	0.002	0.012	0.029
article logging	00:01:04.833	0.1%	2274024	0.011	0.029	0.253
article parse	00:47:58.611	3.3%	127115906	0.012	0.023	0.068
article write	00:23:18.695	1.6%	2269746	0.214	0.616	3.284
artlog/artcncl	00:00:00.001	0.0%	207	0.000	0.005	0.056
data move	00:03:07.819	0.2%	141373065	0.000	0.001	0.006
hisgrep/artcncl	00:00:00.377	0.0%	185	0.000	2.038	102.000
hishave/artcncl	00:00:00.166	0.0%	209	0.000	0.794	13.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:31:06.440	2.2%	2313174	0.061	0.807	10.643
history sync	00:00:00.016	0.0%	291	0.000	0.055	1.000
history write	00:49:56.118	3.5%	2270155	0.155	1.320	27.431
hiswrite/artcncl	00:00:00.064	0.0%	24	0.000	2.667	29.000
idle	15:44:49.886	65.6%	103984542	0.116	0.545	2.029
nntp read	00:48:50.263	3.4%	125380346	0.015	0.023	0.038
overview write	00:00:12.596	0.0%	2269746	0.000	0.006	0.016
perl filter	04:21:34.047	18.2%	2270155	3.206	6.913	9.239
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:44.632	0.3%	4599294	0.030	0.049	0.091
TOTAL: 23:59:23.954	23:36:16.553	98.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.360	0.0%	154641	0.000	0.002	0.231
article prepare	00:00:00.010	0.0%	55040	0.000	0.000	0.025
article read	00:00:32.218	0.0%	13727	0.000	2.347	835.000
backlog stats	00:00:00.230	0.0%	335090	0.000	0.001	0.022
callbacks	00:00:00.000	0.0%	12	0.000	0.000	0.000
data read	00:00:02.163	0.0%	184874	0.000	0.012	0.121
data write	00:00:12.138	0.0%	129855	0.000	0.093	1.261
idle	23:59:14.947	99.9%	335090	37.310	257.707	1640.865
status file	00:00:10.503	0.0%	15045	0.000	0.698	4.933
TOTAL: 24:00:24.406	24:00:12.569	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:39:21.441	99.4%	7324	0.000	322.425	83755.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.290	0.0%	15676	0.000	0.018	0.500
readart	00:00:01.718	0.1%	179	0.000	9.598	21.822
TOTAL: 00:39:34.665	00:39:23.449	99.5%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	189

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	938	2271515	2267652	444	3419	99%	272:51:49
2	news.nask.pl	2	16425	3937	12130	358	23%	24:15:38
3	news.icm.edu.pl	41	177	15	149	13	8%	15:25:53
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		987	2288122	2271609	12723	3790	99%	312:33:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	712.4 GB	10.1 MB	15.2 MB	712.4 GB	99%	328.9 KB
2	news.nask.pl	12.8 MB	881.8 KB	1016.2 KB	14.7 MB	87%	3.5 KB
3	news.icm.edu.pl	208.5 KB	0.0 KB	261.1 KB	469.6 KB	44%	16.8 KB
4	localhost	7.3 KB	0.0 KB	0.0 KB	7.3 KB	100%	1.5 KB
TOTAL: 4		712.4 GB	11.0 MB	16.5 MB	712.4 GB	99%	328.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 9 04:15:02 - 04:59:59	70937	3.1%	26.29	24.4 GB	3.4%	9489.07
Oct 9 05:00:00 - 05:59:59	100002	4.4%	27.78	33.3 GB	4.7%	9686.65
Oct 9 06:00:00 - 06:59:59	110436	4.9%	30.68	31.3 GB	4.4%	9103.44
Oct 9 07:00:00 - 07:59:59	79120	3.5%	21.98	27.8 GB	3.9%	8092.01
Oct 9 08:00:00 - 08:59:59	93226	4.1%	25.90	33.5 GB	4.7%	9746.66
Oct 9 09:00:00 - 09:59:59	48384	2.1%	13.44	16.0 GB	2.2%	4646.51
Oct 9 10:00:00 - 10:59:59	34332	1.5%	9.54	11.7 GB	1.6%	3396.85
Oct 9 11:00:00 - 11:59:59	104254	4.6%	28.96	34.2 GB	4.8%	9966.88
Oct 9 12:00:00 - 12:59:59	83291	3.7%	23.14	27.1 GB	3.8%	7901.18
Oct 9 13:00:00 - 13:59:59	112208	4.9%	31.17	37.4 GB	5.3%	10905.65
Oct 9 14:00:00 - 14:59:59	100451	4.4%	27.90	34.8 GB	4.9%	10150.45
Oct 9 15:00:00 - 15:59:59	102530	4.5%	28.48	34.0 GB	4.8%	9907.10
Oct 9 16:00:00 - 16:59:59	89512	3.9%	24.86	27.5 GB	3.9%	8002.79
Oct 9 17:00:00 - 17:59:59	101348	4.5%	28.15	29.0 GB	4.1%	8451.03
Oct 9 18:00:00 - 18:59:59	103722	4.6%	28.81	31.6 GB	4.4%	9192.62
Oct 9 19:00:00 - 19:59:59	123794	5.5%	34.39	33.8 GB	4.8%	9855.17
Oct 9 20:00:00 - 20:59:59	93832	4.1%	26.06	28.4 GB	4.0%	8283.73
Oct 9 21:00:00 - 21:59:59	104252	4.6%	28.96	30.1 GB	4.2%	8769.35
Oct 9 22:00:00 - 22:59:59	112415	5.0%	31.23	31.5 GB	4.4%	9170.61
Oct 9 23:00:00 - 23:59:59	96497	4.2%	26.80	27.0 GB	3.8%	7852.96
Oct 10 00:00:00 - 00:59:59	81058	3.6%	22.52	24.7 GB	3.5%	7195.04
Oct 10 01:00:00 - 01:59:59	94319	4.2%	26.20	28.6 GB	4.0%	8344.48
Oct 10 02:00:00 - 02:59:59	104405	4.6%	29.00	34.6 GB	4.9%	10087.80
Oct 10 03:00:00 - 03:59:59	99833	4.4%	27.73	31.4 GB	4.4%	9152.99
Oct 10 04:00:00 - 04:15:02	26662	1.2%	29.56	8.4 GB	1.2%	9717.81
TOTAL: 24:00:00	2270820	100.0%	26.28	712.1 GB	100.0%	8642.01

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3869	235	3050	2	582
2	news.nask.pl	399	15	295	11	78
3	news.icm.edu.pl	12	0	0	0	12
TOTAL: 3		4280	250	3345	13	672

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	75
it.comp.os.win.windows10	66
it.tlc.cellulari.android	49
comp.mobile.android	16
it.comp.os.win.windows7	16
alt.sex.telephones	7
comp.sys.mac.vintage	7
de.comp.office-pakete.ms-office.excel	5
hr.alt.cellular.gsm.android	4
comp.mobile.ipad	1
gmane.comp.gis.openstreetmap.devel	1
de.comp.office-pakete.ms-office.misc	1
it.discussioni.energia	1
it.comp.os.linux.ubuntu	1
TOTAL: 14	250

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

Groups	Count
pl.praca.oferowana	9
pl.sci.matematyka	2
bit.listserv.catholic	1
pl.sci.historia	1
TOTAL: 4	13

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	124
EMP (md5)	7
Too many newsgroups	7
HTML post	7
Scoring filter (10)	1
TOTAL: 5	146

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	55296	941	25978	11288	0	9	1%	24:00:00
2	panorama	105165	696	79247	284	32	74319	0%	23:59:48
3	poznan	6028	53	3851	20	0	0	0%	24:02:34
4	okapi	0	0	0	0	0	2509	0%	24:00:02
5	nask	0	0	0	0	0	12538	0%	24:00:02
TOTAL: 5		166489	1690	109076	11592	32	89375	1%	120:02:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	10.5 MB	2.7 GB	2.7 GB	33.2 KB/s	234.9 KB	24:00:00
2	panorama	2.8 MB	2.3 MB	5.1 MB	0.1 KB/s	5.3 KB	23:59:48
3	poznan	171.2 KB	45.9 KB	217.1 KB	0.0 KB/s	3.0 KB	24:02:34
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		13.4 MB	2.7 GB	2.7 GB	6.7 KB/s	216.7 KB	120:02:26

Backlog files shrunk by innfeed:

Server	Size
okapi	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	100	104.9 KB	47	0	00:00:32
2	lze200.lze.lodz.pl	2	73	151.3 KB	4	0	00:30:42
3	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 3		295	173	256.2 KB	51	5	00:39:34

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	677	100	104.9 KB	47	5	00:00:36
2	*.lze.lodz.pl	2	73	151.3 KB	4	0	00:30:42
3	unresolved	4	0	0.0 KB	0	0	00:08:06
4	*.toya.net.pl	58	0	0.0 KB	0	0	00:00:03
5	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:05
TOTAL: 5		743	173	256.2 KB	51	5	00:39:34

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
lze200.lze.lodz.pl	0.020	0.037	00:30:42
185.48.192.96	0.189	0.337	00:08:04
web.man.lodz.pl	0.993	2.854	00:00:32
host227.elsnet.pl	0.008	0.008	00:00:05
mon.man.lodz.pl	0.887	2.493	00:00:03
staticline41435.toya.net.pl	0.228	0.585	00:00:03
173.0.15.147	0.007	0.022	00:00:02
david.man.lodz.pl	0.294	0.889	00:00:00
isvcs01.man.lodz.pl	0.027	0.065	00:00:00
TOTAL: 9	2.653	7.290	00:39:34

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	58
host227.elsnet.pl	2
185.48.192.96	2
173.0.15.147	2
TOTAL: 6	448

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	173	100.0%
TOTAL: 1		173	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	95
2	pl.comp.os.ms-windows.winnt	51
3	pl.rec.kuchnia	24
4	pl.misc.telefonia.gsm	3
TOTAL: 4		173

Daily Usenet report

Oct 9 04:15:02 -- Oct 10 04:15:02