Daily Usenet report: Mar 30 04:15:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Mar 30 04:15:02 newsfeed nnrpd[13624]: web.man.lodz.pl rejected Flushing log and syslog files
Mar 30 04:15:02 newsfeed nnrpd[13630]: web.man.lodz.pl rejected Flushing log and syslog files
Mar 30 08:43:33 newsfeed overchan[2537]: input line too long, skipping
Mar 30 08:45:43 newsfeed nnrpd[7080]: SERVER perl filter not defined
Mar 30 08:46:41 newsfeed nnrpd[7081]: SERVER perl filter not defined
Mar 30 16:06:27 newsfeed nnrpd[22027]: SERVER perl filter not defined
Mar 30 22:55:08 newsfeed nnrpd[3459]: message repeated 3 times: [ pc-55050.zdnet.com.pl group lodz.ogloszenia 0]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2729353	98.7%	322.8 MB	98.4%
innd	26826	1.0%	4.2 MB	1.3%
innfeed	4857	0.2%	678.6 KB	0.2%
nnrpd	4757	0.2%	485.5 KB	0.1%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	2765794	100.0%	328.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2722987	96.6%
Negative hits	81760	2.9%
Positive hits	13684	0.5%
Cache misses	110	0.0%
TOTAL: 4	2818541	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.007	0.0%	242	0.000	12.426	975.000
article cleanup	00:00:41.789	0.0%	2728524	0.007	0.015	0.026
article logging	00:01:27.994	0.1%	2729269	0.016	0.032	0.619
article parse	01:16:08.827	5.3%	218374484	0.013	0.021	0.064
article write	00:24:25.681	1.7%	2717798	0.353	0.539	4.473
artlog/artcncl	00:00:00.007	0.0%	228	0.000	0.031	1.000
data move	00:03:43.391	0.3%	236030274	0.000	0.001	0.007
hisgrep/artcncl	00:00:00.675	0.0%	223	0.000	3.027	157.000
hishave/artcncl	00:00:00.075	0.0%	242	0.000	0.310	8.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:27:51.930	1.9%	2818963	0.112	0.593	7.629
history sync	00:00:00.020	0.0%	290	0.000	0.069	1.000
history write	00:41:45.446	2.9%	2723541	0.195	0.920	9.545
hiswrite/artcncl	00:00:01.001	0.0%	19	0.000	52.684	975.000
idle	13:20:10.115	55.6%	156035525	0.161	0.308	0.744
nntp read	01:16:33.582	5.3%	216250597	0.014	0.021	0.034
overview write	00:00:15.832	0.0%	2717798	0.000	0.006	0.013
perl filter	05:50:49.845	24.4%	2723541	6.053	7.729	9.757
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:52.817	0.3%	5462556	0.036	0.054	0.104
TOTAL: 24:00:09.222	23:28:52.034	97.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.134	0.0%	37360	0.000	0.004	0.143
article prepare	00:00:00.007	0.0%	37336	0.000	0.000	0.042
article read	00:00:50.805	0.1%	9346	0.000	5.436	347.400
backlog stats	00:00:00.154	0.0%	168907	0.000	0.001	0.036
callbacks	00:00:00.000	0.0%	13	0.000	0.000	0.000
data read	00:00:01.286	0.0%	90463	0.000	0.014	0.111
data write	00:00:04.922	0.0%	73675	0.000	0.067	0.302
idle	23:59:24.556	99.9%	168907	19.663	511.314	3868.412
status file	00:00:00.649	0.0%	876	0.000	0.741	5.000
TOTAL: 24:00:27.520	24:00:22.513	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:15:27.686	98.6%	3042	0.000	304.959	89592.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.199	0.0%	6722	0.000	0.030	0.500
readart	00:00:00.020	0.0%	34	0.000	0.588	10.000
TOTAL: 00:15:41.219	00:15:27.905	98.6%	-	-	-	-

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	1145	2718094	2707603	5033	5458	99%	324:54:35
2	news.nask.pl	2	18616	9933	3355	5328	53%	24:29:19
3	news.icm.edu.pl	43	292	12	277	3	4%	17:11:22
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		1194	2737005	2717551	8665	10789	99%	366:35:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	868.9 GB	147.0 MB	233.3 MB	869.3 GB	99%	336.0 KB
2	news.nask.pl	84.3 MB	1.1 MB	113.1 MB	198.6 MB	42%	13.3 KB
3	news.icm.edu.pl	279.2 KB	8.1 KB	79.5 KB	366.8 KB	76%	24.5 KB
4	localhost	4.0 KB	0.0 KB	0.0 KB	4.0 KB	100%	1.3 KB
TOTAL: 4		869.0 GB	148.1 MB	346.5 MB	869.4 GB	99%	334.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 30 04:15:02 - 04:59:59	84170	3.1%	31.20	28.0 GB	3.2%	10879.59
Mar 30 05:00:00 - 05:59:59	109005	4.0%	30.28	36.6 GB	4.2%	10670.65
Mar 30 06:00:00 - 06:59:59	111206	4.1%	30.89	36.4 GB	4.2%	10599.21
Mar 30 07:00:00 - 07:59:59	109824	4.0%	30.51	37.2 GB	4.3%	10826.68
Mar 30 08:00:00 - 08:59:59	122864	4.5%	34.13	38.6 GB	4.5%	11253.74
Mar 30 09:00:00 - 09:59:59	123358	4.5%	34.27	37.2 GB	4.3%	10828.57
Mar 30 10:00:00 - 10:59:59	121886	4.5%	33.86	38.2 GB	4.4%	11124.75
Mar 30 11:00:00 - 11:59:59	117360	4.3%	32.60	37.0 GB	4.3%	10785.64
Mar 30 12:00:00 - 12:59:59	90985	3.3%	25.27	31.0 GB	3.6%	9016.85
Mar 30 13:00:00 - 13:59:59	109992	4.0%	30.55	35.6 GB	4.1%	10379.28
Mar 30 14:00:00 - 14:59:59	110880	4.1%	30.80	36.1 GB	4.2%	10523.00
Mar 30 15:00:00 - 15:59:59	115747	4.3%	32.15	37.6 GB	4.3%	10959.69
Mar 30 16:00:00 - 16:59:59	121406	4.5%	33.72	37.3 GB	4.3%	10875.18
Mar 30 17:00:00 - 17:59:59	119489	4.4%	33.19	37.6 GB	4.3%	10947.02
Mar 30 18:00:00 - 18:59:59	123654	4.6%	34.35	38.0 GB	4.4%	11070.47
Mar 30 19:00:00 - 19:59:59	120179	4.4%	33.38	37.8 GB	4.4%	11020.80
Mar 30 20:00:00 - 20:59:59	121419	4.5%	33.73	37.9 GB	4.4%	11029.80
Mar 30 21:00:00 - 21:59:59	124920	4.6%	34.70	38.0 GB	4.4%	11066.28
Mar 30 22:00:00 - 22:59:59	119602	4.4%	33.22	36.2 GB	4.2%	10553.54
Mar 30 23:00:00 - 23:59:59	118003	4.3%	32.78	35.7 GB	4.1%	10406.25
Mar 31 00:00:00 - 00:59:59	88455	3.3%	24.57	26.8 GB	3.1%	7796.39
Mar 31 01:00:00 - 01:59:59	105386	3.9%	29.27	34.8 GB	4.0%	10127.99
Mar 31 02:00:00 - 02:59:59	109203	4.0%	30.33	36.9 GB	4.3%	10759.21
Mar 31 03:00:00 - 03:59:59	92214	3.4%	25.61	32.4 GB	3.7%	9450.39
Mar 31 04:00:00 - 04:15:02	26448	1.0%	29.32	8.7 GB	1.0%	10111.85
TOTAL: 24:00:00	2717655	100.0%	31.45	867.8 GB	100.0%	10531.61

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	5832	357	4663	0	812
2	news.nask.pl	5634	34	319	4	5277
3	news.icm.edu.pl	4	0	1	0	3
TOTAL: 3		11470	391	4983	4	6092

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it.tlc.cellulari.android	170
uk.railway	121
it.comp.os.win.windows10	39
comp.mobile.android	29
uk.rec.cycling.moderated	10
comp.mobile.ipad	8
nl.comp.os.linux.techniek	5
hr.alt.cellular.gsm.android	4
comp.sys.raspberry-pi	3
alt.sex.telephones	2
TOTAL: 10	391

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

Groups	Count
pl.praca.oferowana	3
bit.listserv.catholic	1
TOTAL: 2	4

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	4348
Binary in non-binary group	872
Scoring filter (8)	35
Scoring filter (10)	30
Excessively crossposted test article	20
Scoring filter (9)	19
HTML post	7
Scoring filter (11)	5
Scoring filter (14)	5
Scoring filter (12)	3
Scoring filter (13)	2
Attached HTML file	1
TOTAL: 12	5347

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	33516	3601	21100	1197	1	0	10%	24:00:18
2	panorama	10469	3357	5068	673	29	28070	32%	23:57:54
3	poznan	15080	237	9437	6	0	0	1%	23:59:02
4	nask	6253	14	4248	0	0	0	0%	23:59:37
5	okapi	0	0	0	0	0	2227	0%	24:00:02
TOTAL: 5		65318	7209	39853	1876	30	30297	11%	119:56:53

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	653.8 MB	382.2 MB	1.0 GB	12.3 KB/s	221.1 KB	24:00:18
2	panorama	23.0 MB	2.2 MB	25.2 MB	0.3 KB/s	6.4 KB	23:57:54
3	poznan	864.0 KB	17.5 KB	881.5 KB	0.0 KB/s	3.6 KB	23:59:02
4	nask	294.3 KB	0.0 KB	294.3 KB	0.0 KB/s	21.0 KB	23:59:37
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		678.0 MB	384.4 MB	1.0 GB	2.5 KB/s	119.7 KB	119:56:53

Backlog files shrunk by innfeed:

Server	Size
panorama	2.4 MB
TOTAL: 1	2.4 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	291	32	30.1 KB	14	0	00:00:26
2	pc-55050.zdnet.com.pl	4	2	3.5 KB	2	0	00:15:09
3	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 3		298	34	33.6 KB	16	3	00:15:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	668	32	30.1 KB	14	3	00:00:31
2	*.zdnet.com.pl	4	2	3.5 KB	2	0	00:15:09
TOTAL: 2		672	34	33.6 KB	16	3	00:15:40

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-55050.zdnet.com.pl	0.044	0.026	00:15:09
web.man.lodz.pl	1.037	3.405	00:00:26
mon.man.lodz.pl	0.900	2.654	00:00:03
david.man.lodz.pl	0.317	0.953	00:00:01
isvcs01.man.lodz.pl	0.017	0.038	00:00:00
TOTAL: 5	2.315	7.076	00:15:40

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	278
david.man.lodz.pl	96
TOTAL: 2	374

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	32	94.1%
2	lodz	2	5.9%
TOTAL: 2		34	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	22
2	pl.comp.os.ms-windows.winnt	10
3	lodz.ogloszenia	2
TOTAL: 3		34

Daily Usenet report

Mar 30 04:15:02 -- Mar 31 04:15:02