Daily Usenet report: Mar 21 04:15:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Mar 21 04:15:02 newsfeed nnrpd[21659]: web.man.lodz.pl rejected Flushing log and syslog files
Mar 21 04:15:02 newsfeed nnrpd[21665]: web.man.lodz.pl rejected Flushing log and syslog files
Mar 22 00:50:02 newsfeed controlchan[2629]: Multiple control headers in article <tnBHk-216-23@gated-at.bofh.it>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2858122	98.5%	336.6 MB	98.3%
innd	32557	1.1%	4.8 MB	1.4%
innfeed	4885	0.2%	682.4 KB	0.2%
nnrpd	4787	0.2%	496.0 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	2900352	100.0%	342.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2847238	95.8%
Negative hits	107219	3.6%
Positive hits	18654	0.6%
Cache misses	119	0.0%
TOTAL: 4	2973230	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.065	0.0%	197	0.000	10.482	416.000
article cleanup	00:00:42.747	0.0%	2857337	0.007	0.015	0.025
article logging	00:01:38.769	0.1%	2857923	0.016	0.035	1.772
article parse	01:18:45.547	5.5%	199017926	0.015	0.024	0.069
article write	00:33:53.167	2.4%	2839089	0.365	0.716	17.818
artlog/artcncl	00:00:00.005	0.0%	179	0.000	0.028	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:57.069	0.2%	217118483	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.235	0.0%	176	0.000	1.335	53.000
hishave/artcncl	00:00:00.040	0.0%	197	0.000	0.203	1.389
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:31:54.881	2.2%	2975968	0.121	0.643	7.947
history sync	00:00:00.018	0.0%	296	0.000	0.061	1.000
history write	00:47:33.042	3.3%	2849960	0.207	1.001	11.214
hiswrite/artcncl	00:00:00.003	0.0%	21	0.000	0.143	1.000
idle	12:20:28.944	51.4%	135166517	0.148	0.329	0.542
nntp read	01:12:50.627	5.1%	196773891	0.015	0.022	0.035
overview write	00:00:15.926	0.0%	2839089	0.001	0.006	0.013
perl filter	06:11:39.893	25.8%	2849960	6.206	7.825	9.583
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:58.632	0.3%	5743072	0.035	0.052	0.089
TOTAL: 23:59:52.945	23:07:41.610	96.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.319	0.0%	98224	0.000	0.003	0.125
article prepare	00:00:00.053	0.0%	163924	0.000	0.000	0.042
article read	00:01:09.834	0.1%	40975	0.000	1.704	602.200
backlog stats	00:00:00.442	0.0%	396456	0.000	0.001	0.045
callbacks	00:00:00.000	0.0%	14	0.000	0.000	0.000
data read	00:00:02.629	0.0%	187430	0.000	0.014	0.123
data write	00:00:22.979	0.0%	208916	0.000	0.110	0.324
idle	23:57:46.192	99.9%	396456	15.022	217.593	7573.500
status file	00:00:00.750	0.0%	967	0.000	0.776	3.000
TOTAL: 23:59:32.938	23:59:23.198	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	13:20:09.767	99.9%	399700	0.000	120.115	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:17.721	0.0%	800050	0.000	0.022	0.579
readart	00:00:00.003	0.0%	36	0.000	0.083	0.500
TOTAL: 13:21:11.910	13:20:27.491	99.9%	-	-	-	-

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	1092	2840067	2824459	7404	8204	99%	370:32:11
2	news.nask.pl	2	28049	14387	3561	10101	51%	23:39:54
3	news.icm.edu.pl	44	307	21	238	48	6%	16:27:25
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		1139	2868423	2838867	11203	18353	98%	410:39:30

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	892.1 GB	1.0 GB	1.2 GB	894.3 GB	99%	331.0 KB
2	news.nask.pl	1.0 GB	12.2 MB	159.3 MB	1.2 GB	85%	50.1 KB
3	news.icm.edu.pl	686.6 KB	0.0 KB	759.1 KB	1.4 MB	47%	21.0 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		893.1 GB	1.0 GB	1.3 GB	895.5 GB	99%	328.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 21 04:15:01 - 04:59:59	98322	3.5%	36.43	28.6 GB	3.2%	11100.81
Mar 21 05:00:00 - 05:59:59	115623	4.1%	32.12	38.2 GB	4.3%	11137.80
Mar 21 06:00:00 - 06:59:59	110111	3.9%	30.59	38.4 GB	4.3%	11191.46
Mar 21 07:00:00 - 07:59:59	109013	3.8%	30.28	38.9 GB	4.4%	11317.57
Mar 21 08:00:00 - 08:59:59	112592	4.0%	31.28	38.6 GB	4.3%	11245.25
Mar 21 09:00:00 - 09:59:59	121038	4.3%	33.62	38.7 GB	4.3%	11272.32
Mar 21 10:00:00 - 10:59:59	121480	4.3%	33.74	37.6 GB	4.2%	10964.21
Mar 21 11:00:00 - 11:59:59	125423	4.4%	34.84	38.6 GB	4.3%	11236.35
Mar 21 12:00:00 - 12:59:59	122602	4.3%	34.06	37.1 GB	4.2%	10813.23
Mar 21 13:00:00 - 13:59:59	117009	4.1%	32.50	35.5 GB	4.0%	10349.94
Mar 21 14:00:00 - 14:59:59	116578	4.1%	32.38	35.6 GB	4.0%	10366.25
Mar 21 15:00:00 - 15:59:59	117958	4.2%	32.77	36.0 GB	4.0%	10488.72
Mar 21 16:00:00 - 16:59:59	113515	4.0%	31.53	35.1 GB	3.9%	10226.44
Mar 21 17:00:00 - 17:59:59	110347	3.9%	30.65	35.2 GB	3.9%	10239.64
Mar 21 18:00:00 - 18:59:59	116628	4.1%	32.40	37.9 GB	4.2%	11025.50
Mar 21 19:00:00 - 19:59:59	123361	4.3%	34.27	38.6 GB	4.3%	11249.84
Mar 21 20:00:00 - 20:59:59	127854	4.5%	35.52	37.6 GB	4.2%	10963.62
Mar 21 21:00:00 - 21:59:59	126062	4.4%	35.02	37.4 GB	4.2%	10898.79
Mar 21 22:00:00 - 22:59:59	129993	4.6%	36.11	39.2 GB	4.4%	11412.92
Mar 21 23:00:00 - 23:59:59	124242	4.4%	34.51	38.6 GB	4.3%	11246.52
Mar 22 00:00:00 - 00:59:59	99975	3.5%	27.77	32.1 GB	3.6%	9362.30
Mar 22 01:00:00 - 01:59:59	123220	4.3%	34.23	38.0 GB	4.3%	11068.92
Mar 22 02:00:00 - 02:59:59	124175	4.4%	34.49	38.8 GB	4.4%	11310.82
Mar 22 03:00:00 - 03:59:59	105764	3.7%	29.38	32.5 GB	3.6%	9467.89
Mar 22 04:00:00 - 04:15:01	26223	0.9%	29.10	8.4 GB	0.9%	9829.95
TOTAL: 24:00:00	2839108	100.0%	32.86	891.4 GB	100.0%	10818.29

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	10199	65	355	4	9775
2	newsfeed.pionier.net.pl	8588	198	7023	1	1366
3	news.icm.edu.pl	48	0	0	0	48
TOTAL: 3		18835	263	7378	5	11189

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it.tlc.cellulari.android	120
comp.sys.raspberry-pi	51
uk.railway	47
it.comp.os.win.windows10	13
comp.mobile.android	13
uk.rec.cycling.moderated	4
de.comm.software.mailreader	4
de.comp.os.os2	3
alt.sex.telephones	2
hr.ponuda.hardver.komponente	2
nl.actueel	1
nl.comp.sys.android	1
uk.net.providers.gradwell	1
nl.comp.os.linux.techniek	1
TOTAL: 14	263

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

Groups	Count
pl.praca.oferowana	3
bit.listserv.catholic	1
pl.sci.matematyka	1
TOTAL: 3	5

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	8854
Binary in non-binary group	1494
Poison newsgroup	96
Scoring filter (10)	74
Scoring filter (8)	38
Scoring filter (9)	28
Scoring filter (12)	7
HTML post	5
Scoring filter (11)	2
Scoring filter (23)	2
Scoring filter (15)	1
Attached HTML file	1
EMP (fsl)	1
TOTAL: 13	10603

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	69277	34458	26072	3716	2	961	49%	23:59:23
2	panorama	37724	1940	33599	625	28	61168	5%	23:59:16
3	poznan	15810	54	10434	9	0	0	0%	24:00:03
4	nask	7793	37	5195	0	0	0	0%	23:52:28
5	okapi	0	0	0	0	0	2226	0%	24:00:01
TOTAL: 5		130604	36489	75300	4350	30	64355	27%	119:51:11

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	6.1 GB	1.3 GB	7.5 GB	90.6 KB/s	205.0 KB	23:59:23
2	nask	7.9 MB	0.0 KB	7.9 MB	0.1 KB/s	219.0 KB	23:52:28
3	panorama	5.6 MB	3.5 MB	9.2 MB	0.1 KB/s	3.7 KB	23:59:16
4	poznan	293.6 KB	27.3 KB	320.9 KB	0.0 KB/s	5.1 KB	24:00:03
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		6.1 GB	1.4 GB	7.5 GB	18.2 KB/s	192.0 KB	119:51:11

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	290	36	38.0 KB	18	0	0	00:00:21
TOTAL: 1		290	36	38.0 KB	18	0	0	13:21:11

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.man.lodz.pl	674	36	38.0 KB	18	00:00:26
2	unresolved	7	0	0.0 KB	0	13:20:44
TOTAL: 2		681	36	38.0 KB	18	13:21:11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89.38.41.49	22.321	29.204	10:51:11
185.48.195.208	3.918	5.453	01:54:14
89.38.41.204	0.119	0.097	00:35:18
web.man.lodz.pl	1.022	5.699	00:00:21
mon.man.lodz.pl	0.945	5.103	00:00:03
david.man.lodz.pl	0.267	1.657	00:00:01
TOTAL: 6	28.592	47.213	13:21:11

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
89.38.41.49	4
89.38.41.204	2
185.48.195.208	1
TOTAL: 5	391

NNRP client timeouts [Top 20]:

System	Conn	Peer
89.38.41.49	2	1
185.48.195.208	1	0
89.38.41.204	1	0
TOTAL: 3	4	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Mar 21 04:15:01 -- Mar 22 04:15:01