Daily Usenet report: Mar 23 04:15:04

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Mar 23 10:10:32 newsfeed overchan[12351]: input line too long, skipping
Mar 23 10:10:47 newsfeed overchan[12351]: input line too long, skipping
Mar 23 12:00:17 newsfeed nnrpd[30051]: SERVER perl filter not defined
Mar 23 12:01:05 newsfeed nnrpd[30074]: SERVER perl filter not defined
Mar 23 12:02:22 newsfeed nnrpd[30092]: SERVER perl filter not defined
Mar 23 12:03:33 newsfeed nnrpd[30245]: SERVER perl filter not defined
Mar 23 16:03:43 newsfeed overchan[12351]: input line too long, skipping
Mar 23 20:51:27 newsfeed overchan[12351]: input line too long, skipping
Mar 23 20:54:20 newsfeed overchan[12351]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3389296	97.9%	377.0 MB	97.5%
innfeed	45755	1.3%	5.4 MB	1.4%
innd	23812	0.7%	3.9 MB	1.0%
nnrpd	4773	0.1%	507.7 KB	0.1%
overchan	6	0.0%	1.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3463643	100.0%	386.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3367590	96.5%
Negative hits	109295	3.1%
Positive hits	10930	0.3%
Cache misses	113	0.0%
TOTAL: 4	3487928	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.393	0.0%	182	0.000	13.148	124.000
article cleanup	00:00:41.292	0.0%	3392147	0.008	0.012	0.019
article logging	00:02:16.024	0.2%	3392790	0.027	0.040	0.087
article parse	00:48:26.526	3.4%	83179210	0.021	0.035	0.049
article write	00:20:06.110	1.4%	3387667	0.200	0.356	0.836
artlog/artcncl	00:00:00.002	0.0%	179	0.000	0.011	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:01:59.304	0.1%	99545701	0.001	0.001	0.003
hisgrep/artcncl	00:00:00.263	0.0%	176	0.000	1.494	27.000
hishave/artcncl	00:00:00.138	0.0%	182	0.000	0.758	6.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:34:19.602	2.4%	3511927	0.063	0.586	4.905
history sync	00:00:00.024	0.0%	290	0.000	0.083	0.500
history write	01:37:13.819	6.8%	3390132	0.204	1.721	5.750
hiswrite/artcncl	00:00:00.000	0.0%	6	0.000	0.000	0.000
idle	13:45:45.259	57.3%	60566412	0.485	0.818	2.118
nntp read	00:53:59.026	3.7%	80599620	0.024	0.040	0.055
overview write	00:00:17.344	0.0%	3387667	0.003	0.005	0.007
perl filter	05:18:23.436	22.1%	3390132	3.786	5.635	7.828
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:06:05.508	0.4%	6795749	0.035	0.054	0.080
TOTAL: 24:00:01.876	23:29:36.070	97.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.175	0.0%	59791	0.000	0.003	0.013
article prepare	00:00:00.003	0.0%	13688	0.000	0.000	0.016
article read	00:00:35.390	0.0%	3405	0.000	10.394	210.600
backlog stats	00:00:00.179	0.0%	177317	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	11	0.000	0.000	0.000
data read	00:00:01.555	0.0%	92309	0.003	0.017	0.038
data write	00:00:07.500	0.0%	74069	0.024	0.101	0.394
idle	23:52:51.299	99.9%	177317	235.826	484.845	940.620
status file	00:00:16.526	0.0%	16329	0.540	1.012	1.463
TOTAL: 23:54:03.334	23:53:52.627	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:39.060	0.1%	355831	0.110	0.110	0.110
idle	10:15:21.271	99.6%	358867	0.000	102.883	10044.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:21.022	0.1%	718340	0.000	0.029	0.667
readart	00:01:11.108	0.2%	355661	0.000	0.200	0.500
TOTAL: 10:18:07.242	10:17:32.461	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	193

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1022	3382688	3373035	7593	2060	99%	446:22:06
2	news.nask.pl	2	13523	10022	1078	2423	74%	24:14:11
3	news.icm.edu.pl	38	206	20	185	1	9%	15:12:41
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		1067	3396421	3383081	8856	4484	99%	485:48:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	723.2 GB	7.9 MB	8.9 MB	723.2 GB	99%	224.7 KB
2	news.nask.pl	35.6 MB	666.5 KB	11.7 MB	48.0 MB	74%	3.9 KB
3	news.icm.edu.pl	421.7 KB	0.0 KB	15.8 KB	437.5 KB	96%	20.8 KB
4	localhost	6.3 KB	0.0 KB	0.0 KB	6.3 KB	100%	1.6 KB
TOTAL: 4		723.2 GB	8.6 MB	20.7 MB	723.2 GB	99%	223.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 23 04:15:04 - 04:59:59	93548	2.8%	34.70	22.8 GB	3.2%	8877.43
Mar 23 05:00:00 - 05:59:59	160213	4.7%	44.50	32.7 GB	4.5%	9517.43
Mar 23 06:00:00 - 06:59:59	128227	3.8%	35.62	32.5 GB	4.5%	9473.77
Mar 23 07:00:00 - 07:59:59	126857	3.7%	35.24	35.4 GB	4.9%	10310.69
Mar 23 08:00:00 - 08:59:59	133688	4.0%	37.14	38.3 GB	5.3%	11162.00
Mar 23 09:00:00 - 09:59:59	173055	5.1%	48.07	35.1 GB	4.9%	10230.81
Mar 23 10:00:00 - 10:59:59	162269	4.8%	45.07	35.8 GB	4.9%	10418.72
Mar 23 11:00:00 - 11:59:59	160702	4.7%	44.64	35.2 GB	4.9%	10264.89
Mar 23 12:00:00 - 12:59:59	239876	7.1%	66.63	37.0 GB	5.1%	10773.40
Mar 23 13:00:00 - 13:59:59	205614	6.1%	57.12	34.8 GB	4.8%	10123.18
Mar 23 14:00:00 - 14:59:59	170306	5.0%	47.31	36.5 GB	5.0%	10627.02
Mar 23 15:00:00 - 15:59:59	160182	4.7%	44.49	29.0 GB	4.0%	8451.12
Mar 23 16:00:00 - 16:59:59	154364	4.6%	42.88	30.4 GB	4.2%	8861.67
Mar 23 17:00:00 - 17:59:59	140607	4.2%	39.06	31.4 GB	4.3%	9158.46
Mar 23 18:00:00 - 18:59:59	130478	3.9%	36.24	27.4 GB	3.8%	7980.89
Mar 23 19:00:00 - 19:59:59	135535	4.0%	37.65	29.2 GB	4.0%	8497.46
Mar 23 20:00:00 - 20:59:59	123369	3.6%	34.27	23.4 GB	3.2%	6821.76
Mar 23 21:00:00 - 21:59:59	127493	3.8%	35.41	24.8 GB	3.4%	7209.98
Mar 23 22:00:00 - 22:59:59	132721	3.9%	36.87	23.0 GB	3.2%	6689.43
Mar 23 23:00:00 - 23:59:59	106233	3.1%	29.51	23.4 GB	3.2%	6805.26
Mar 24 00:00:00 - 00:59:59	77301	2.3%	21.47	17.9 GB	2.5%	5202.67
Mar 24 01:00:00 - 01:59:59	100546	3.0%	27.93	25.0 GB	3.5%	7277.36
Mar 24 02:00:00 - 02:59:59	114651	3.4%	31.85	29.2 GB	4.0%	8510.59
Mar 24 03:00:00 - 03:59:59	105367	3.1%	29.27	27.8 GB	3.8%	8086.70
Mar 24 04:00:00 - 04:15:02	20791	0.6%	23.05	5.8 GB	0.8%	6780.62
TOTAL: 23:59:58	3383993	100.0%	39.17	723.7 GB	100.0%	8783.64

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	2636	12	205	11	2408
2	newsfeed.pionier.net.pl	2481	205	1811	0	465
3	news.icm.edu.pl	7	0	0	0	7
TOTAL: 3		5124	217	2016	11	2880

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	126
it.comp.os.win.windows10	49
it.tlc.cellulari.android	22
de.rec.kunst	6
comp.sys.raspberry-pi	5
de.rec.sf.startrek	3
openwatcom.users.assembler	2
it.comp.os.win.windows7	2
it.tlc.cellulari.iphone	1
comp.mobile.android	1
TOTAL: 10	217

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2044
Binary in non-binary group	82
EMP (phl)	61
Scoring filter (8)	22
Scoring filter (9)	11
Scoring filter (10)	6
Scoring filter (16)	5
Scoring filter (11)	2
Attached HTML file	1
Scoring filter (18)	1
Scoring filter (17)	1
HTML post	1
Too many test groups in crosspost	1
TOTAL: 13	2238

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	421
	news.nask.pl	221
	TOTAL: 2	642
TOTAL: 1		642

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	44055	474	16270	107	14	43105	1%	23:59:56
2	poznan	16578	430	9479	7	0	0	2%	23:59:56
3	icm	26516	34	18153	1864	0	0	0%	23:59:20
4	nask	2854	4	2045	0	0	0	0%	23:56:15
5	okapi	0	0	0	0	0	1149	0%	23:57:49
TOTAL: 5		90003	942	45947	1978	14	44254	1%	119:53:16

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	2.3 MB	697.5 MB	699.9 MB	8.3 KB/s	377.6 KB	23:59:20
2	panorama	1.5 MB	300.8 KB	1.8 MB	0.0 KB/s	3.2 KB	23:59:56
3	poznan	1.4 MB	20.1 KB	1.4 MB	0.0 KB/s	3.2 KB	23:59:56
4	nask	8.6 KB	0.0 KB	8.6 KB	0.0 KB/s	2.1 KB	23:56:15
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:49
TOTAL: 5		5.2 MB	697.8 MB	703.0 MB	1.7 KB/s	246.5 KB	119:53:16

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	26	20.4 KB	13	0	00:00:20
2	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 2		292	26	20.4 KB	13	4	10:18:06

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	676	26	20.4 KB	13	4	00:00:26
2	unresolved	2	0	0.0 KB	0	0	10:17:40
TOTAL: 2		678	26	20.4 KB	13	4	10:18:06

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.99	32.864	115.136	10:17:40
web.man.lodz.pl	1.524	7.144	00:00:20
mon.man.lodz.pl	1.324	6.632	00:00:03
david.man.lodz.pl	0.536	2.292	00:00:01
isvcs01.man.lodz.pl	0.036	0.084	00:00:00
TOTAL: 5	36.284	131.288	10:18:06

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.48.193.99	2
TOTAL: 3	386

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Mar 23 04:15:04 -- Mar 24 04:15:02