Daily Usenet report: Mar 5 04:15:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Mar 5 21:11:12 newsfeed nnrpd[18569]: SERVER perl filter not defined
Mar 5 21:56:43 newsfeed nnrpd[20079]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3249141	98.6%	372.3 MB	98.3%
innd	36253	1.1%	5.2 MB	1.4%
innfeed	4940	0.1%	701.1 KB	0.2%
nnrpd	4727	0.1%	491.4 KB	0.1%
TOTAL: 4	3295061	100.0%	378.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3239523	97.6%
Negative hits	69388	2.1%
Positive hits	11387	0.3%
Cache misses	111	0.0%
TOTAL: 4	3320409	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.449	0.0%	215	0.000	16.042	241.143
article cleanup	00:00:47.411	0.1%	3247445	0.007	0.015	0.023
article logging	00:01:52.548	0.1%	3247985	0.017	0.035	0.793
article parse	01:21:49.775	5.7%	180324113	0.016	0.027	0.071
article write	01:08:27.175	4.8%	3229073	0.372	1.272	5.527
artlog/artcncl	00:00:00.006	0.0%	209	0.000	0.029	1.000
artlog/artparse	00:00:00.000	0.0%	32	0.000	0.000	0.000
data move	00:02:51.712	0.2%	199388608	0.000	0.001	0.004
hisgrep/artcncl	00:00:01.730	0.0%	200	0.000	8.650	206.429
hishave/artcncl	00:00:00.133	0.0%	215	0.000	0.619	24.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:33:46.236	2.3%	3322750	0.130	0.610	8.359
history sync	00:00:00.013	0.0%	294	0.000	0.044	1.000
history write	00:50:32.706	3.5%	3241861	0.239	0.935	10.653
hiswrite/artcncl	00:00:00.009	0.0%	15	0.000	0.600	3.000
idle	11:30:08.207	47.9%	115514454	0.169	0.358	0.625
nntp read	01:12:44.809	5.1%	177688380	0.017	0.025	0.039
overview write	00:00:19.676	0.0%	3229073	0.001	0.006	0.013
perl filter	06:25:50.490	26.8%	3241829	5.595	7.141	10.001
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:52.158	0.4%	6678829	0.023	0.053	0.099
TOTAL: 23:59:38.900	23:15:08.243	96.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.958	0.0%	249798	0.000	0.004	0.250
article prepare	00:00:00.193	0.0%	843592	0.000	0.000	0.125
article read	00:07:43.659	0.5%	210563	0.000	2.202	116.357
backlog stats	00:00:01.210	0.0%	1120328	0.000	0.001	0.045
callbacks	00:00:00.000	0.0%	17	0.000	0.000	0.000
data read	00:00:06.718	0.0%	487260	0.000	0.014	0.158
data write	00:01:46.049	0.1%	643190	0.000	0.165	0.621
idle	23:50:22.509	99.3%	1120328	15.541	76.605	4325.357
status file	00:00:00.830	0.0%	1057	0.000	0.785	4.500
TOTAL: 24:00:29.956	24:00:02.126	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:32:36.477	99.3%	8330	0.000	234.871	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.421	0.0%	17292	0.000	0.024	0.842
readart	00:00:00.020	0.0%	39	0.000	0.513	8.500
TOTAL: 00:32:49.964	00:32:36.918	99.3%	-	-	-	-

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	1027	3231883	3222111	2621	7151	99%	443:50:21
2	news.nask.pl	2	22029	7973	2821	11235	36%	23:59:40
3	news.icm.edu.pl	36	334	17	283	34	5%	17:21:02
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		1068	3254248	3230103	5725	18420	99%	485:11:03

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	920.1 GB	67.0 MB	361.2 MB	920.5 GB	99%	298.9 KB
2	news.nask.pl	45.9 MB	1.4 MB	176.8 MB	224.1 MB	20%	11.9 KB
3	news.icm.edu.pl	378.8 KB	248.3 KB	2.3 MB	2.9 MB	12%	57.9 KB
4	localhost	4.8 KB	0.0 KB	0.0 KB	4.8 KB	100%	2.4 KB
TOTAL: 4		920.1 GB	68.6 MB	540.2 MB	920.7 GB	99%	297.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 5 04:15:02 - 04:59:59	87736	2.7%	32.52	25.6 GB	2.8%	9950.78
Mar 5 05:00:00 - 05:59:59	129083	4.0%	35.86	37.8 GB	4.1%	11006.18
Mar 5 06:00:00 - 06:59:59	136226	4.2%	37.84	39.3 GB	4.3%	11442.97
Mar 5 07:00:00 - 07:59:59	139828	4.3%	38.84	40.0 GB	4.4%	11643.30
Mar 5 08:00:00 - 08:59:59	139023	4.3%	38.62	39.8 GB	4.3%	11580.03
Mar 5 09:00:00 - 09:59:59	141035	4.4%	39.18	38.9 GB	4.2%	11340.65
Mar 5 10:00:00 - 10:59:59	134893	4.2%	37.47	38.8 GB	4.2%	11297.85
Mar 5 11:00:00 - 11:59:59	132496	4.1%	36.80	37.7 GB	4.1%	10992.08
Mar 5 12:00:00 - 12:59:59	140382	4.3%	38.99	38.2 GB	4.2%	11128.62
Mar 5 13:00:00 - 13:59:59	140329	4.3%	38.98	38.5 GB	4.2%	11224.11
Mar 5 14:00:00 - 14:59:59	136205	4.2%	37.83	37.7 GB	4.1%	10984.55
Mar 5 15:00:00 - 15:59:59	130990	4.1%	36.39	36.7 GB	4.0%	10684.42
Mar 5 16:00:00 - 16:59:59	126080	3.9%	35.02	36.8 GB	4.0%	10711.55
Mar 5 17:00:00 - 17:59:59	135932	4.2%	37.76	39.4 GB	4.3%	11482.50
Mar 5 18:00:00 - 18:59:59	141107	4.4%	39.20	40.4 GB	4.4%	11777.74
Mar 5 19:00:00 - 19:59:59	140404	4.3%	39.00	40.3 GB	4.4%	11750.99
Mar 5 20:00:00 - 20:59:59	140834	4.4%	39.12	39.9 GB	4.3%	11621.28
Mar 5 21:00:00 - 21:59:59	135462	4.2%	37.63	38.7 GB	4.2%	11267.56
Mar 5 22:00:00 - 22:59:59	136233	4.2%	37.84	38.7 GB	4.2%	11258.55
Mar 5 23:00:00 - 23:59:59	135495	4.2%	37.64	38.5 GB	4.2%	11215.44
Mar 6 00:00:00 - 00:59:59	115150	3.6%	31.99	33.1 GB	3.6%	9641.16
Mar 6 01:00:00 - 01:59:59	138751	4.3%	38.54	39.1 GB	4.3%	11399.44
Mar 6 02:00:00 - 02:59:59	141090	4.4%	39.19	39.6 GB	4.3%	11530.59
Mar 6 03:00:00 - 03:59:59	122812	3.8%	34.11	34.7 GB	3.8%	10105.38
Mar 6 04:00:00 - 04:15:03	32410	1.0%	35.89	9.1 GB	1.0%	10607.82
TOTAL: 24:00:01	3229986	100.0%	37.38	917.4 GB	100.0%	11133.42

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	11469	29	385	1	11054
2	newsfeed.pionier.net.pl	7445	93	5229	0	2123
3	news.icm.edu.pl	33	0	4	0	29
TOTAL: 3		18947	122	5618	1	13206

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it.tlc.cellulari.android	36
uk.railway	33
comp.mobile.android	29
comp.sys.raspberry-pi	12
it.comp.os.win.windows7	4
it.comp.os.win.windows10	4
uk.rec.cycling.moderated	2
hr.ponuda.hardver.komponente	1
hr.ponuda.hardver.periferije	1
TOTAL: 9	122

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

Groups	Count
bit.listserv.catholic	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	10202
Binary in non-binary group	2070
Scoring filter (9)	117
Scoring filter (10)	88
Scoring filter (8)	67
Poison newsgroup	40
EMP (phl)	23
Scoring filter (11)	15
Scoring filter (12)	2
HTML post	2
Too many newsgroups	2
Scoring filter (17)	1
Scoring filter (14)	1
Scoring filter (13)	1
Scoring filter (15)	1
Scoring filter (19)	1
TOTAL: 16	12633

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	217256	193733	12769	8169	12	21282	89%	23:59:29
2	panorama	28411	2068	23684	882	32	201283	7%	23:57:36
3	poznan	12249	250	7688	16	0	0	2%	24:03:02
4	nask	10484	7	3682	5187	0	0	0%	24:03:00
5	okapi	0	0	0	0	0	1169	0%	24:00:02
TOTAL: 5		268400	196058	47823	14254	44	223734	73%	120:03:09

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	34.8 GB	900.5 MB	35.7 GB	432.9 KB/s	185.2 KB	23:59:29
2	panorama	6.4 MB	30.8 MB	37.2 MB	0.4 KB/s	12.9 KB	23:57:36
3	poznan	1.3 MB	278.8 KB	1.6 MB	0.0 KB/s	6.2 KB	24:03:02
4	nask	12.3 KB	1.9 GB	1.9 GB	23.2 KB/s	386.7 KB	24:03:00
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		34.8 GB	2.8 GB	37.6 GB	91.3 KB/s	187.5 KB	120:03:09

Backlog files shrunk by innfeed:

Server	Size
panorama	17.6 MB
okapi	488.3 KB
TOTAL: 2	18.1 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	284	39	38.2 KB	20	1	00:00:22
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 2		285	39	38.2 KB	20	2	00:32:49

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	669	39	38.2 KB	20	2	00:00:27
2	*.43.180.66.ipv4.supernova.orange.pl	2	0	0.0 KB	0	0	00:00:03
3	*.toya.net.pl	1	0	0.0 KB	0	0	00:00:04
4	unresolved	2	0	0.0 KB	0	0	00:32:14
TOTAL: 4		674	39	38.2 KB	20	2	00:32:49

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89.38.40.173	0.363	0.480	00:32:14
web.man.lodz.pl	0.870	6.241	00:00:22
staticline-31-182-214-99.toya.net.pl	0.004	0.020	00:00:04
mon.man.lodz.pl	0.926	5.526	00:00:03
178.43.180.66.ipv4.supernova.orange.pl	0.000	0.050	00:00:03
david.man.lodz.pl	0.318	1.748	00:00:01
isvcs01.man.lodz.pl	0.006	0.011	00:00:00
TOTAL: 7	2.487	14.076	00:32:49

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
178.43.180.66.ipv4.supernova.orange.pl	2
89.38.40.173	2
staticline-31-182-214-99.toya.net.pl	1
TOTAL: 5	389

NNRP client timeouts [Top 20]:

System	Conn	Peer
89.38.40.173	2	0
TOTAL: 1	2	0

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	38	97.4%
2	lodman	1	2.6%
TOTAL: 2		39	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	22
2	pl.comp.os.ms-windows.winnt	16
3	lodman.test	1
TOTAL: 3		39

Daily Usenet report

Mar 5 04:15:02 -- Mar 6 04:15:03