Daily Usenet report: Jun 1 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Jun 1 10:57:15 newsfeed nnrpd[6756]: SERVER perl filter not defined
Jun 1 11:18:32 newsfeed nnrpd[7467]: SERVER perl filter not defined
Jun 1 11:45:56 newsfeed nnrpd[8475]: SERVER perl filter not defined
Jun 1 12:31:41 newsfeed nnrpd[10105]: SERVER perl filter not defined
Jun 1 12:33:06 newsfeed nnrpd[10111]: SERVER perl filter not defined
Jun 1 15:26:04 newsfeed nnrpd[16068]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2368926	96.7%	273.3 MB	96.3%
innfeed	48178	2.0%	5.7 MB	2.0%
innd	28080	1.1%	4.3 MB	1.5%
nnrpd	5040	0.2%	529.2 KB	0.2%
TOTAL: 4	2450224	100.0%	283.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2362478	94.9%
Negative hits	107523	4.3%
Positive hits	19720	0.8%
Cache misses	127	0.0%
TOTAL: 4	2489848	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.871	0.0%	273	0.000	6.853	92.000
article cleanup	00:00:30.982	0.0%	2368283	0.004	0.013	0.028
article logging	00:01:06.296	0.1%	2368981	0.013	0.028	1.405
article parse	01:17:52.684	5.4%	245390702	0.009	0.019	0.045
article write	00:31:28.550	2.2%	2354446	0.378	0.802	4.929
artlog/artcncl	00:00:00.009	0.0%	262	0.000	0.034	1.000
data move	00:03:05.454	0.2%	262275573	0.000	0.001	0.007
hisgrep/artcncl	00:00:00.304	0.0%	233	0.000	1.305	19.000
hishave/artcncl	00:00:00.047	0.0%	273	0.000	0.172	5.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:29:02.148	2.0%	2491268	0.056	0.699	19.405
history sync	00:00:00.013	0.0%	291	0.000	0.045	1.000
history write	00:39:30.795	2.7%	2363970	0.190	1.003	34.369
hiswrite/artcncl	00:00:00.033	0.0%	40	0.000	0.825	13.000
idle	13:37:27.460	56.8%	183725447	0.119	0.267	1.089
nntp read	01:16:56.504	5.3%	243673365	0.010	0.019	0.029
overview write	00:00:12.661	0.0%	2354446	0.000	0.005	0.014
perl filter	05:18:14.176	22.1%	2363970	4.884	8.077	11.625
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:01.328	0.3%	4773421	0.035	0.051	0.084
TOTAL: 24:00:14.571	23:19:31.315	97.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.306	0.0%	117738	0.000	0.003	0.091
article prepare	00:00:00.049	0.0%	156128	0.000	0.000	0.042
article read	00:01:18.095	0.1%	38961	0.000	2.004	279.455
backlog stats	00:00:00.303	0.0%	444439	0.000	0.001	0.014
callbacks	00:00:00.000	0.0%	16	0.000	0.000	0.000
data read	00:00:02.655	0.0%	222519	0.000	0.012	0.188
data write	00:00:23.172	0.0%	217864	0.000	0.106	0.837
idle	23:57:09.294	99.8%	444439	14.462	194.018	1080.464
status file	00:00:13.061	0.0%	16186	0.250	0.807	140.167
TOTAL: 23:59:21.786	23:59:06.935	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.153	0.0%	6	25.500	25.500	25.500
idle	02:09:57.209	99.8%	8776	0.000	888.470	471085.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.336	0.0%	18410	0.000	0.018	0.667
readart	00:00:01.371	0.0%	110	0.000	12.464	254.000
TOTAL: 02:10:11.835	02:09:59.069	99.8%	-	-	-	-

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	908	2353784	2340150	9337	4297	99%	290:53:13
2	news.nask.pl	2	29099	14038	5619	9442	48%	24:13:11
3	news.icm.edu.pl	32	454	40	390	24	8%	19:41:25
4	localhost	7	6	6	0	0	100%	00:00:01
TOTAL: 4		949	2383343	2354234	15346	13763	98%	334:47:50

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	872.5 GB	171.6 MB	194.6 MB	872.9 GB	99%	390.4 KB
2	news.nask.pl	528.1 MB	10.0 MB	175.7 MB	713.8 MB	73%	31.1 KB
3	news.icm.edu.pl	791.2 KB	32.8 KB	302.6 KB	1.1 MB	70%	17.6 KB
4	localhost	9.1 KB	0.0 KB	0.0 KB	9.1 KB	100%	1.5 KB
TOTAL: 4		873.0 GB	181.6 MB	370.6 MB	873.6 GB	99%	386.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 1 04:15:02 - 04:59:59	66159	2.8%	24.52	31.5 GB	3.6%	12247.12
Jun 1 05:00:00 - 05:59:59	90764	3.9%	25.21	39.6 GB	4.5%	11526.02
Jun 1 06:00:00 - 06:59:59	98133	4.2%	27.26	36.4 GB	4.2%	10600.36
Jun 1 07:00:00 - 07:59:59	97880	4.2%	27.19	39.4 GB	4.5%	11466.58
Jun 1 08:00:00 - 08:59:59	81463	3.5%	22.63	40.2 GB	4.6%	11721.22
Jun 1 09:00:00 - 09:59:59	78496	3.3%	21.80	38.3 GB	4.4%	11149.20
Jun 1 10:00:00 - 10:59:59	86206	3.7%	23.95	35.9 GB	4.1%	10448.28
Jun 1 11:00:00 - 11:59:59	105804	4.5%	29.39	39.3 GB	4.5%	11451.36
Jun 1 12:00:00 - 12:59:59	120646	5.1%	33.51	38.9 GB	4.4%	11321.07
Jun 1 13:00:00 - 13:59:59	123142	5.2%	34.21	40.0 GB	4.6%	11661.29
Jun 1 14:00:00 - 14:59:59	122916	5.2%	34.14	39.1 GB	4.5%	11384.14
Jun 1 15:00:00 - 15:59:59	127065	5.4%	35.30	41.1 GB	4.7%	11977.12
Jun 1 16:00:00 - 16:59:59	110727	4.7%	30.76	38.3 GB	4.4%	11154.01
Jun 1 17:00:00 - 17:59:59	98451	4.2%	27.35	37.1 GB	4.2%	10809.86
Jun 1 18:00:00 - 18:59:59	104554	4.4%	29.04	39.1 GB	4.5%	11389.58
Jun 1 19:00:00 - 19:59:59	103576	4.4%	28.77	35.5 GB	4.1%	10332.25
Jun 1 20:00:00 - 20:59:59	99455	4.2%	27.63	34.6 GB	4.0%	10064.96
Jun 1 21:00:00 - 21:59:59	115467	4.9%	32.07	34.8 GB	4.0%	10137.69
Jun 1 22:00:00 - 22:59:59	80062	3.4%	22.24	26.7 GB	3.1%	7784.50
Jun 1 23:00:00 - 23:59:59	106509	4.5%	29.59	37.7 GB	4.3%	10970.70
Jun 2 00:00:00 - 00:59:59	84394	3.6%	23.44	27.8 GB	3.2%	8085.11
Jun 2 01:00:00 - 01:59:59	78740	3.3%	21.87	29.3 GB	3.4%	8532.63
Jun 2 02:00:00 - 02:59:59	71248	3.0%	19.79	32.7 GB	3.7%	9510.80
Jun 2 03:00:00 - 03:59:59	80320	3.4%	22.31	32.9 GB	3.8%	9590.30
Jun 2 04:00:00 - 04:15:02	21945	0.9%	24.33	7.9 GB	0.9%	9175.29
TOTAL: 24:00:00	2354122	100.0%	27.25	873.9 GB	100.0%	10606.10

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	9722	28	333	5	9356
2	newsfeed.pionier.net.pl	4795	167	3978	0	650
3	news.icm.edu.pl	25	0	2	1	22
TOTAL: 3		14542	195	4313	6	10028

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	106
comp.mobile.ipad	21
comp.mobile.android	18
it.tlc.cellulari.android	17
it.comp.os.win.windows10	16
it.comp.os.win.windows7	8
hr.ponuda.hardver.konfiguracije	2
nl.comp.sys.android	2
alt.sex.telephones	1
hr.ponuda.hardver.komponente	1
de.comp.office-pakete.ms-office.outlook	1
it.tlc.cellulari.iphone	1
de.rec.kunst	1
TOTAL: 13	195

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	8290
Binary in non-binary group	508
PFM bot misc	232
Scoring filter (8)	148
Scoring filter (9)	35
EMP (phl)	22
EMP (fsl)	20
Scoring filter (13)	14
Scoring filter (10)	14
Scoring filter (12)	12
Scoring filter (11)	11
Scoring filter (16)	4
Scoring filter (14)	3
hierarchy violation - crosspost outside cl	3
Scoring filter (18)	3
Scoring filter (21)	2
Scoring filter (15)	2
HTML post	2
Scoring filter (24)	1
Scoring filter (22)	1
TOTAL: 23	9330

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	71587	20987	27202	13631	0	284	29%	23:58:35
2	panorama	60300	2402	30530	442	44	83936	3%	23:59:51
3	poznan	21600	407	12940	44	0	0	1%	24:06:30
4	nask	12044	402	7720	11	0	0	3%	24:00:16
5	okapi	0	0	0	0	0	2857	0%	24:00:00
TOTAL: 5		165531	24198	78392	14128	44	87077	14%	120:05:12

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	3.7 GB	3.3 GB	7.0 GB	84.7 KB/s	211.2 KB	23:58:35
2	nask	90.2 MB	2.5 MB	92.7 MB	1.1 KB/s	229.8 KB	24:00:16
3	poznan	42.5 MB	5.0 MB	47.6 MB	0.6 KB/s	108.0 KB	24:06:30
4	panorama	19.2 MB	2.4 MB	21.6 MB	0.3 KB/s	7.8 KB	23:59:51
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		3.9 GB	3.3 GB	7.1 GB	17.3 KB/s	195.1 KB	120:05:12

Backlog files shrunk by innfeed:

Server	Size
panorama	3.8 MB
okapi	488.4 KB
TOTAL: 2	4.3 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	54	60.3 KB	23	0	00:00:24
2	dmcs2.p.lodz.pl	6	39	75.8 KB	5	0	00:53:49
3	pc-212-51-218-225.p.lodz.pl	3	13	29.7 KB	3	0	01:03:41
4	212.51.203.199	2	2	113.4 KB	1	0	00:01:55
5	isvcs01.man.lodz.pl	6	0	0.0 KB	0	6	00:00:00
TOTAL: 5		305	108	279.3 KB	32	6	02:10:11

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	678	54	60.3 KB	23	6	00:00:29
2	*.p.lodz.pl	9	52	105.5 KB	8	0	01:57:31
3	unresolved	4	2	113.4 KB	1	0	00:12:08
4	*.toya.net.pl	39	0	0.0 KB	0	0	00:00:02
TOTAL: 4		730	108	279.3 KB	32	6	02:10:11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-51-218-225.p.lodz.pl	0.009	0.040	01:03:41
dmcs2.p.lodz.pl	0.026	0.054	00:53:49
185.48.195.188	0.299	0.358	00:10:12
212.51.203.199	0.008	0.006	00:01:55
web.man.lodz.pl	0.955	2.816	00:00:24
mon.man.lodz.pl	0.942	2.910	00:00:03
staticline41435.toya.net.pl	0.143	0.406	00:00:02
david.man.lodz.pl	0.306	0.875	00:00:00
isvcs01.man.lodz.pl	0.055	0.063	00:00:00
TOTAL: 9	2.743	7.528	02:10:11

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	39
185.48.195.188	2
TOTAL: 4	425

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	2	0
dmcs2.p.lodz.pl	1	1
TOTAL: 2	3	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.misc.elektronika	32
2	pl.comp.pecet	30
3	pl.comp.os.ms-windows.winnt	24
4	pl.misc.kolej	20
5	pl.rec.radio.amatorskie	2
TOTAL: 5		108

Daily Usenet report

Jun 1 04:15:02 -- Jun 2 04:15:02