Daily Usenet report: Sep 23 04:15:02

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Sep 23 19:19:42 newsfeed overchan[685]: input line too long, skipping
Sep 23 19:22:47 newsfeed overchan[685]: input line too long, skipping
Sep 23 19:47:10 newsfeed overchan[685]: input line too long, skipping
Sep 23 19:56:52 newsfeed overchan[685]: input line too long, skipping
Sep 23 20:13:00 newsfeed overchan[685]: input line too long, skipping
Sep 23 22:51:43 newsfeed overchan[685]: input line too long, skipping
Sep 24 03:08:18 newsfeed overchan[685]: input line too long, skipping
Sep 24 03:08:47 newsfeed overchan[685]: input line too long, skipping
Sep 24 03:11:35 newsfeed overchan[685]: input line too long, skipping
Sep 24 03:11:57 newsfeed overchan[685]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2313312	96.3%	267.8 MB	95.9%
innfeed	47047	2.0%	5.5 MB	2.0%
innd	37614	1.6%	5.4 MB	1.9%
nnrpd	4726	0.2%	496.1 KB	0.2%
overchan	11	0.0%	1.9 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2402711	100.0%	279.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2296921	91.2%
Negative hits	195042	7.7%
Positive hits	26500	1.1%
Cache misses	190	0.0%
TOTAL: 4	2518653	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.879	0.0%	267	0.000	7.037	878.000
article cleanup	00:00:39.661	0.0%	2312989	0.012	0.017	0.022
article logging	00:01:46.170	0.1%	2313590	0.035	0.046	0.145
article parse	01:03:16.293	4.4%	146850763	0.015	0.026	0.060
article write	00:24:43.494	1.7%	2277657	0.415	0.651	2.499
artlog/artcncl	00:00:00.003	0.0%	176	0.000	0.017	0.500
data move	00:03:38.005	0.3%	161064301	0.001	0.001	0.005
hisgrep/artcncl	00:00:00.904	0.0%	263	0.000	3.437	492.000
hishave/artcncl	00:00:00.067	0.0%	267	0.000	0.251	1.880
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:36:56.386	2.6%	2522145	0.062	0.879	5.106
history sync	00:00:00.016	0.0%	290	0.000	0.055	1.000
history write	01:45:07.910	7.3%	2299502	0.388	2.743	11.398
hiswrite/artcncl	00:00:00.041	0.0%	4	0.000	10.250	29.000
idle	13:03:00.411	54.4%	98229680	0.155	0.478	0.809
nntp read	01:09:44.272	4.8%	144982654	0.022	0.029	0.040
overview write	00:00:14.767	0.0%	2277657	0.005	0.006	0.009
perl filter	05:12:28.499	21.7%	2299502	6.754	8.153	9.661
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:26.666	0.3%	4579228	0.044	0.058	0.082
TOTAL: 24:00:01.442	23:26:05.444	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.188	0.0%	64932	0.000	0.003	0.012
article prepare	00:00:00.010	0.0%	25032	0.000	0.000	0.050
article read	00:00:59.351	0.1%	6253	0.000	9.492	433.643
backlog stats	00:00:00.198	0.0%	191059	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	6	0.000	0.000	0.000
data read	00:00:02.341	0.0%	98549	0.002	0.024	0.076
data write	00:00:13.254	0.0%	87630	0.015	0.151	0.465
idle	23:52:13.991	99.9%	191059	102.962	449.777	1153.802
status file	00:00:18.321	0.0%	16014	0.700	1.144	9.800
TOTAL: 23:54:06.765	23:53:47.654	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:19.726	43.6%	3004	0.000	6.567	137.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.163	0.4%	6640	0.000	0.025	0.667
readart	00:00:00.000	0.0%	28	0.000	0.000	0.000
TOTAL: 00:00:45.236	00:00:19.889	44.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	934	2295521	2269258	9191	17072	98%	357:52:06
2	news.nask.pl	3	29889	8312	3550	18027	27%	23:44:54
3	news.icm.edu.pl	44	346	37	271	38	10%	17:56:25
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		982	2325756	2277607	13012	35137	97%	399:33:25

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	712.2 GB	1.9 GB	2.7 GB	716.8 GB	99%	328.7 KB
2	news.nask.pl	368.9 MB	113.3 MB	2.7 GB	3.2 GB	11%	128.2 KB
3	news.icm.edu.pl	821.7 KB	16.5 KB	1.6 MB	2.4 MB	33%	33.0 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		712.5 GB	2.0 GB	5.4 GB	720.0 GB	98%	326.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 23 04:15:02 - 04:59:59	85856	3.8%	31.82	30.5 GB	4.3%	11871.92
Sep 23 05:00:00 - 05:59:59	119550	5.2%	33.21	40.7 GB	5.7%	11847.34
Sep 23 06:00:00 - 06:59:59	93845	4.1%	26.07	33.0 GB	4.6%	9625.57
Sep 23 07:00:00 - 07:59:59	105255	4.6%	29.24	32.6 GB	4.6%	9505.54
Sep 23 08:00:00 - 08:59:59	128938	5.7%	35.82	42.1 GB	5.9%	12265.79
Sep 23 09:00:00 - 09:59:59	113768	5.0%	31.60	37.4 GB	5.3%	10886.99
Sep 23 10:00:00 - 10:59:59	89251	3.9%	24.79	29.8 GB	4.2%	8678.19
Sep 23 11:00:00 - 11:59:59	41697	1.8%	11.58	16.1 GB	2.3%	4689.14
Sep 23 12:00:00 - 12:59:59	53414	2.3%	14.84	16.9 GB	2.4%	4931.87
Sep 23 13:00:00 - 13:59:59	65363	2.9%	18.16	20.9 GB	2.9%	6076.53
Sep 23 14:00:00 - 14:59:59	62423	2.7%	17.34	19.4 GB	2.7%	5653.03
Sep 23 15:00:00 - 15:59:59	61502	2.7%	17.08	19.2 GB	2.7%	5600.66
Sep 23 16:00:00 - 16:59:59	92511	4.1%	25.70	29.7 GB	4.2%	8650.13
Sep 23 17:00:00 - 17:59:59	94416	4.1%	26.23	31.4 GB	4.4%	9157.38
Sep 23 18:00:00 - 18:59:59	105931	4.7%	29.43	32.7 GB	4.6%	9513.71
Sep 23 19:00:00 - 19:59:59	70015	3.1%	19.45	19.2 GB	2.7%	5583.39
Sep 23 20:00:00 - 20:59:59	67797	3.0%	18.83	19.5 GB	2.7%	5673.32
Sep 23 21:00:00 - 21:59:59	110532	4.9%	30.70	32.9 GB	4.6%	9570.85
Sep 23 22:00:00 - 22:59:59	141962	6.2%	39.43	41.1 GB	5.8%	11968.24
Sep 23 23:00:00 - 23:59:59	128158	5.6%	35.60	37.1 GB	5.2%	10807.21
Sep 24 00:00:00 - 00:59:59	105048	4.6%	29.18	29.3 GB	4.1%	8525.93
Sep 24 01:00:00 - 01:59:59	107385	4.7%	29.83	29.9 GB	4.2%	8707.03
Sep 24 02:00:00 - 02:59:59	113760	5.0%	31.60	33.5 GB	4.7%	9754.65
Sep 24 03:00:00 - 03:59:59	93633	4.1%	26.01	28.9 GB	4.1%	8409.37
Sep 24 04:00:00 - 04:15:02	25351	1.1%	28.11	7.9 GB	1.1%	9188.56
TOTAL: 24:00:00	2277361	100.0%	26.36	711.6 GB	100.0%	8636.73

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	18291	7	923	1	17360
2	newsfeed.pionier.net.pl	17443	127	12484	1	4831
3	news.icm.edu.pl	41	0	2	0	39
TOTAL: 3		35775	134	13409	2	22230

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	96
it.tlc.cellulari.android	12
it.comp.os.win.windows10	10
comp.sys.raspberry-pi	4
de.rec.sf.startrek	4
comp.mobile.android	3
de.comp.office-pakete.ms-office.word	3
it.comp.os.win.windows7	1
it.comp.os.linux.ubuntu	1
TOTAL: 9	134

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	18482
EMP (md5)	2997
Scoring filter (8)	83
Scoring filter (10)	33
Scoring filter (9)	19
Too many newsgroups	3
Scoring filter (12)	3
Bad X-Cancelled-By	2
Scoring filter (14)	2
HTML post	2
Too many newsgroups (low_xpost)	1
Scoring filter (13)	1
Scoring filter (11)	1
TOTAL: 13	21629

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	391
	news.nask.pl	207
	news.icm.edu.pl	3
	TOTAL: 3	601
TOTAL: 1		601

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	45232	629	17750	158	18	46597	1%	23:59:57
2	poznan	11385	75	7295	40	0	0	0%	23:59:57
3	icm	27169	41	18448	4740	0	0	0%	23:59:55
4	nask	6871	5	5330	0	0	0	0%	23:59:57
5	okapi	0	0	0	0	0	1312	0%	23:57:50
TOTAL: 5		90657	750	48823	4938	18	47909	0%	119:57:36

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	5.3 MB	1.7 MB	7.0 MB	0.1 KB/s	9.1 KB	23:59:57
2	icm	592.5 KB	2.1 GB	2.1 GB	25.0 KB/s	451.1 KB	23:59:55
3	poznan	419.4 KB	199.0 KB	618.4 KB	0.0 KB/s	5.4 KB	23:59:57
4	nask	366.4 KB	0.0 KB	366.4 KB	0.0 KB/s	73.3 KB	23:59:57
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:50
TOTAL: 5		6.6 MB	2.1 GB	2.1 GB	5.0 KB/s	380.6 KB	119:57:36

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	288	28	23.0 KB	11	0	0	00:00:31
TOTAL: 1		288	28	23.0 KB	11	0	0	00:00:44

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	672	28	23.0 KB	11	0	0	00:00:44
TOTAL: 1		672	28	23.0 KB	11	0	0	00:00:44

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.524	4.364	00:00:31
mon.man.lodz.pl	1.208	4.136	00:00:09
david.man.lodz.pl	0.444	1.312	00:00:03
TOTAL: 3	3.176	9.812	00:00:44

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
TOTAL: 2	384

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	28
TOTAL: 1		28

Daily Usenet report

Sep 23 04:15:02 -- Sep 24 04:15:02