Daily Usenet report: Jul 1 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jul 1 09:15:14 newsfeed nnrpd[17028]: SERVER perl filter not defined
Jul 1 11:07:53 newsfeed nnrpd[20835]: SERVER perl filter not defined
Jul 1 11:34:53 newsfeed nnrpd[21833]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2338935	98.5%	271.3 MB	98.2%
innd	25163	1.1%	3.8 MB	1.4%
innfeed	4828	0.2%	661.5 KB	0.2%
nnrpd	4769	0.2%	491.2 KB	0.2%
TOTAL: 4	2373695	100.0%	276.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2331715	95.5%
Negative hits	94684	3.9%
Positive hits	14859	0.6%
Cache misses	106	0.0%
TOTAL: 4	2441364	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.590	0.0%	206	0.000	12.573	474.000
article cleanup	00:00:31.341	0.0%	2339378	0.003	0.013	0.030
article logging	00:01:04.267	0.1%	2340067	0.012	0.027	0.480
article parse	01:05:32.084	4.6%	223330897	0.006	0.018	0.061
article write	00:20:59.290	1.5%	2328244	0.307	0.541	3.942
artlog/artcncl	00:00:00.000	0.0%	196	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	17	0.000	0.000	0.000
data move	00:02:49.479	0.2%	239179456	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.144	0.0%	174	0.000	0.828	20.000
hishave/artcncl	00:00:00.092	0.0%	206	0.000	0.447	22.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:22:08.473	1.5%	2444682	0.059	0.543	12.958
history sync	00:00:00.013	0.0%	291	0.000	0.045	2.000
history write	00:32:50.161	2.3%	2335089	0.140	0.844	22.856
hiswrite/artcncl	00:00:00.061	0.0%	32	0.000	1.906	17.000
idle	14:32:35.558	60.6%	171266499	0.138	0.306	1.353
nntp read	01:08:03.514	4.7%	221597704	0.012	0.018	0.035
overview write	00:00:12.463	0.0%	2328244	0.000	0.005	0.017
perl filter	04:52:50.355	20.3%	2335072	5.330	7.525	10.382
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:51.864	0.3%	4687371	0.034	0.049	0.083
TOTAL: 24:00:11.432	23:03:31.749	96.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.122	0.0%	40540	0.000	0.003	0.154
article prepare	00:00:00.006	0.0%	25100	0.000	0.000	0.045
article read	00:00:25.826	0.0%	6705	0.000	3.852	309.400
backlog stats	00:00:00.132	0.0%	177534	0.000	0.001	0.021
callbacks	00:00:00.002	0.0%	306	0.000	0.007	0.333
data read	00:00:01.158	0.0%	99307	0.000	0.012	0.111
data write	00:00:04.010	0.0%	74852	0.000	0.054	0.222
idle	23:59:48.568	100.0%	177534	94.946	486.603	2446.880
status file	00:00:00.581	0.0%	850	0.000	0.684	4.000
TOTAL: 24:00:24.656	24:00:20.405	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:24.168	66.9%	3036	0.000	7.960	1217.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.131	0.4%	6700	0.000	0.020	0.500
readart	00:00:00.003	0.0%	32	0.000	0.094	1.000
TOTAL: 00:00:36.148	00:00:24.302	67.2%	-	-	-	-

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	902	2325845	2313749	7517	4579	99%	269:28:57
2	news.nask.pl	2	22744	13382	2765	6597	58%	24:15:30
3	news.icm.edu.pl	36	246	8	228	10	3%	14:47:24
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		944	2348838	2327142	10510	11186	99%	308:31:51

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	774.4 GB	43.6 MB	125.7 MB	774.6 GB	99%	350.3 KB
2	news.nask.pl	74.6 MB	1.2 MB	68.3 MB	144.1 MB	51%	7.4 KB
3	news.icm.edu.pl	310.6 KB	0.0 KB	784.5 KB	1.1 MB	28%	60.8 KB
4	localhost	4.1 KB	0.0 KB	0.0 KB	4.1 KB	100%	1.4 KB
TOTAL: 4		774.5 GB	44.8 MB	194.8 MB	774.7 GB	99%	347.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 1 04:15:02 - 04:59:59	80927	3.5%	30.00	28.3 GB	3.7%	10994.90
Jul 1 05:00:00 - 05:59:59	110245	4.7%	30.62	38.4 GB	5.0%	11197.87
Jul 1 06:00:00 - 06:59:59	119861	5.2%	33.29	39.8 GB	5.1%	11606.52
Jul 1 07:00:00 - 07:59:59	137152	5.9%	38.10	39.9 GB	5.2%	11626.98
Jul 1 08:00:00 - 08:59:59	95646	4.1%	26.57	30.9 GB	4.0%	8997.84
Jul 1 09:00:00 - 09:59:59	113604	4.9%	31.56	37.9 GB	4.9%	11027.66
Jul 1 10:00:00 - 10:59:59	107634	4.6%	29.90	35.7 GB	4.6%	10408.20
Jul 1 11:00:00 - 11:59:59	116349	5.0%	32.32	38.4 GB	4.9%	11172.23
Jul 1 12:00:00 - 12:59:59	105634	4.5%	29.34	36.0 GB	4.6%	10483.75
Jul 1 13:00:00 - 13:59:59	109274	4.7%	30.35	36.3 GB	4.7%	10566.58
Jul 1 14:00:00 - 14:59:59	100090	4.3%	27.80	34.3 GB	4.4%	9987.14
Jul 1 15:00:00 - 15:59:59	100906	4.3%	28.03	33.8 GB	4.4%	9858.37
Jul 1 16:00:00 - 16:59:59	111627	4.8%	31.01	37.9 GB	4.9%	11045.96
Jul 1 17:00:00 - 17:59:59	131205	5.6%	36.45	39.6 GB	5.1%	11532.75
Jul 1 18:00:00 - 18:59:59	120290	5.2%	33.41	38.4 GB	5.0%	11176.49
Jul 1 19:00:00 - 19:59:59	118391	5.1%	32.89	39.3 GB	5.1%	11448.17
Jul 1 20:00:00 - 20:59:59	128451	5.5%	35.68	39.2 GB	5.1%	11431.83
Jul 1 21:00:00 - 21:59:59	105300	4.5%	29.25	33.3 GB	4.3%	9693.67
Jul 1 22:00:00 - 22:59:59	71428	3.1%	19.84	23.8 GB	3.1%	6931.67
Jul 1 23:00:00 - 23:59:59	59535	2.6%	16.54	21.1 GB	2.7%	6144.07
Jul 2 00:00:00 - 00:59:59	41023	1.8%	11.40	14.7 GB	1.9%	4294.41
Jul 2 01:00:00 - 01:59:59	47992	2.1%	13.33	19.2 GB	2.5%	5603.14
Jul 2 02:00:00 - 02:59:59	41662	1.8%	11.57	17.0 GB	2.2%	4948.43
Jul 2 03:00:00 - 03:59:59	42470	1.8%	11.80	17.1 GB	2.2%	4974.83
Jul 2 04:00:00 - 04:15:02	10210	0.4%	11.32	4.5 GB	0.6%	5283.51
TOTAL: 24:00:00	2326906	100.0%	26.93	775.0 GB	100.0%	9405.10

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	6797	116	308	8	6365
2	newsfeed.pionier.net.pl	5026	145	3992	0	889
3	news.icm.edu.pl	10	0	0	0	10
TOTAL: 3		11833	261	4300	8	7264

Unwanted newsgroups [Top 20]:

Newsgroup	Count
comp.mobile.ipad	111
uk.railway	83
comp.mobile.android	28
it.comp.os.win.windows10	19
uk.rec.cycling.moderated	3
de.rec.sf.startrek	3
de.comm.software.mailreader	3
it.tlc.cellulari.android	2
alt.sex.telephones	2
de.comp.lang.vbclassic	2
de.comp.lang.php	1
it.tlc.cellulari.iphone	1
hr.sci.med	1
comp.sys.raspberry-pi	1
it.comp.os.win.windows7	1
TOTAL: 15	261

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

Groups	Count
pl.praca.oferowana	7
bit.listserv.catholic	1
TOTAL: 2	8

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	5226
Binary in non-binary group	588
EMP (phl)	223
Scoring filter (8)	155
PFM bot misc	107
Scoring filter (12)	70
Scoring filter (9)	48
Scoring filter (11)	33
Scoring filter (13)	31
Scoring filter (10)	29
Scoring filter (15)	13
HTML post	9
Scoring filter (16)	8
Scoring filter (14)	7
Scoring filter (17)	5
Scoring filter (21)	3
Scoring filter (18)	2
Scoring filter (20)	1
TOTAL: 18	6558

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	9983	1523	5731	527	882	31887	15%	23:56:57
2	icm	33387	522	23967	2795	0	1	1%	23:59:42
3	poznan	21182	260	12906	89	0	0	1%	24:01:16
4	nask	4981	16	3390	2	0	0	0%	23:57:10
5	okapi	0	0	0	0	0	2070	0%	24:00:02
TOTAL: 5		69533	2321	45994	3413	882	33958	3%	119:55:07

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	16.5 MB	659.2 MB	675.7 MB	8.0 KB/s	208.6 KB	23:59:42
2	panorama	3.5 MB	1.4 MB	5.0 MB	0.1 KB/s	2.5 KB	23:56:57
3	poznan	1.1 MB	493.8 KB	1.5 MB	0.0 KB/s	4.5 KB	24:01:16
4	nask	59.7 KB	3.3 MB	3.4 MB	0.0 KB/s	193.1 KB	23:57:10
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		21.1 MB	664.5 MB	685.6 MB	1.6 KB/s	122.4 KB	119:55:07

Backlog files shrunk by innfeed:

Server	Size
panorama	2.4 MB
okapi	488.3 KB
TOTAL: 2	2.9 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	32	38.5 KB	15	0	00:00:21
2	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 2		291	32	38.5 KB	15	3	00:00:35

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	675	32	38.5 KB	15	3	00:00:26
2	unresolved	1	0	0.0 KB	0	0	00:00:00
3	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:09
TOTAL: 3		678	32	38.5 KB	15	3	00:00:35

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	0.879	4.337	00:00:21
host227.elsnet.pl	0.003	0.017	00:00:09
mon.man.lodz.pl	0.945	3.731	00:00:03
david.man.lodz.pl	0.346	1.255	00:00:01
isvcs01.man.lodz.pl	0.027	0.033	00:00:00
TOTAL: 5	2.200	9.373	00:00:35

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
host227.elsnet.pl	2
185.48.194.66	1
TOTAL: 4	387

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	20
2	pl.comp.pecet	12
TOTAL: 2		32

Daily Usenet report

Jul 1 04:15:02 -- Jul 2 04:15:02