Daily Usenet report: Oct 11 04:15:03

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Oct 11 09:33:56 newsfeed nnrpd[1993]: SERVER perl filter not defined
Oct 11 12:36:11 newsfeed overchan[22103]: input line too long, skipping
Oct 11 17:14:33 newsfeed overchan[22103]: input line too long, skipping
Oct 11 17:19:41 newsfeed overchan[22103]: input line too long, skipping
Oct 11 17:26:00 newsfeed overchan[22103]: input line too long, skipping
Oct 11 21:03:15 newsfeed overchan[22103]: input line too long, skipping
Oct 11 21:08:02 newsfeed overchan[22103]: input line too long, skipping
Oct 12 01:24:49 newsfeed overchan[22103]: input line too long, skipping
Oct 12 01:40:50 newsfeed overchan[22103]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2283163	97.3%	267.2 MB	97.0%
innfeed	40921	1.7%	4.8 MB	1.8%
innd	17190	0.7%	2.8 MB	1.0%
nnrpd	4840	0.2%	517.1 KB	0.2%
overchan	9	0.0%	1.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2346124	100.0%	275.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2260635	88.6%
Positive hits	169920	6.7%
Negative hits	120788	4.7%
Cache misses	809	0.0%
TOTAL: 4	2552152	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.512	0.0%	101	0.000	44.673	157.500
article cleanup	00:00:30.761	0.0%	2280803	0.009	0.013	0.019
article logging	00:01:36.095	0.1%	2281311	0.029	0.042	0.069
article parse	00:41:16.138	2.9%	110887422	0.011	0.022	0.047
article write	00:15:06.087	1.0%	2269038	0.244	0.399	0.732
artlog/artcncl	00:00:00.004	0.0%	101	0.000	0.040	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:38.019	0.2%	124115673	0.001	0.001	0.003
hisgrep/artcncl	00:00:01.634	0.0%	100	0.000	16.340	73.778
hishave/artcncl	00:00:00.109	0.0%	101	0.000	1.079	19.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:30:40.981	6.3%	2563862	0.301	2.122	5.587
history sync	00:00:00.018	0.0%	290	0.000	0.062	0.500
history write	03:46:26.566	15.7%	2270588	1.763	5.984	11.645
hiswrite/artcncl	00:00:00.015	0.0%	1	15.000	15.000	15.000
idle	11:59:50.384	50.0%	88879622	0.208	0.486	1.245
nntp read	01:10:46.982	4.9%	109360614	0.025	0.039	0.069
overview write	00:00:11.150	0.0%	2269038	0.003	0.005	0.008
perl filter	03:55:41.154	16.4%	2270588	4.088	6.228	9.936
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:41.946	0.3%	4775230	0.040	0.059	0.089
TOTAL: 24:00:05.524	23:29:32.555	97.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:01.185	0.0%	439576	0.000	0.003	0.006
article prepare	00:00:00.071	0.0%	255180	0.000	0.000	0.002
article read	00:00:26.376	0.0%	58411	0.265	0.452	2.158
backlog stats	00:00:01.545	0.0%	1770702	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:18.967	0.0%	930227	0.009	0.020	0.032
data write	00:03:10.585	0.2%	931259	0.101	0.205	0.406
idle	23:45:34.835	99.6%	1770702	28.259	48.306	110.021
status file	00:00:17.395	0.0%	16207	0.565	1.073	3.149
TOTAL: 23:50:44.019	23:49:50.959	99.9%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:14.491	50.1%	3015	0.000	4.806	45.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.451	1.6%	6666	0.000	0.068	7.421
readart	00:00:00.025	0.1%	32	0.000	0.781	9.500
TOTAL: 00:00:28.947	00:00:14.967	51.7%	-	-	-	-

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	979	2268702	2261418	4101	3183	99%	481:55:13
2	news.nask.pl	2	175358	9234	157568	8556	5%	24:01:25
3	news.icm.edu.pl	44	303	155	116	32	51%	16:14:38
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		1027	2444364	2270808	161785	11771	92%	522:11:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	629.0 GB	708.5 MB	710.2 MB	630.4 GB	99%	291.9 KB
2	news.nask.pl	1.8 GB	2.9 GB	2.9 GB	7.6 GB	23%	445.4 KB
3	news.icm.edu.pl	2.8 MB	83.1 KB	534.6 KB	3.4 MB	82%	18.5 KB
4	localhost	1.3 KB	0.0 KB	0.0 KB	1.3 KB	100%	1.3 KB
TOTAL: 4		630.9 GB	3.6 GB	3.6 GB	638.0 GB	98%	293.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 11 04:15:03 - 04:59:59	67424	3.0%	25.00	21.7 GB	3.4%	8455.64
Oct 11 05:00:00 - 05:59:59	70472	3.1%	19.58	28.8 GB	4.6%	8392.58
Oct 11 06:00:00 - 06:59:59	91098	4.0%	25.30	29.6 GB	4.7%	8630.98
Oct 11 07:00:00 - 07:59:59	92253	4.1%	25.63	31.0 GB	4.9%	9040.48
Oct 11 08:00:00 - 08:59:59	89253	3.9%	24.79	31.8 GB	5.0%	9268.12
Oct 11 09:00:00 - 09:59:59	108573	4.8%	30.16	31.4 GB	5.0%	9140.46
Oct 11 10:00:00 - 10:59:59	115773	5.1%	32.16	29.4 GB	4.7%	8573.31
Oct 11 11:00:00 - 11:59:59	115433	5.1%	32.06	29.5 GB	4.7%	8604.15
Oct 11 12:00:00 - 12:59:59	79210	3.5%	22.00	20.9 GB	3.3%	6089.84
Oct 11 13:00:00 - 13:59:59	82715	3.6%	22.98	22.9 GB	3.6%	6672.13
Oct 11 14:00:00 - 14:59:59	77761	3.4%	21.60	23.4 GB	3.7%	6812.49
Oct 11 15:00:00 - 15:59:59	87494	3.9%	24.30	23.5 GB	3.7%	6830.74
Oct 11 16:00:00 - 16:59:59	116268	5.1%	32.30	33.1 GB	5.2%	9639.76
Oct 11 17:00:00 - 17:59:59	107592	4.7%	29.89	30.4 GB	4.8%	8856.84
Oct 11 18:00:00 - 18:59:59	110031	4.8%	30.56	29.0 GB	4.6%	8460.29
Oct 11 19:00:00 - 19:59:59	123635	5.4%	34.34	33.5 GB	5.3%	9771.74
Oct 11 20:00:00 - 20:59:59	132800	5.8%	36.89	30.7 GB	4.9%	8948.99
Oct 11 21:00:00 - 21:59:59	77298	3.4%	21.47	16.9 GB	2.7%	4934.11
Oct 11 22:00:00 - 22:59:59	106877	4.7%	29.69	22.2 GB	3.5%	6464.34
Oct 11 23:00:00 - 23:59:59	64042	2.8%	17.79	15.8 GB	2.5%	4608.33
Oct 12 00:00:00 - 00:59:59	56732	2.5%	15.76	14.0 GB	2.2%	4085.88
Oct 12 01:00:00 - 01:59:59	68702	3.0%	19.08	16.8 GB	2.7%	4907.04
Oct 12 02:00:00 - 02:59:59	99216	4.4%	27.56	30.2 GB	4.8%	8795.28
Oct 12 03:00:00 - 03:59:59	106851	4.7%	29.68	27.7 GB	4.4%	8081.55
Oct 12 04:00:00 - 04:15:02	23305	1.0%	25.84	6.8 GB	1.1%	7885.58
TOTAL: 23:59:59	2270808	100.0%	26.28	631.4 GB	100.0%	7663.42

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	8677	31	7241	2	1403
2	newsfeed.pionier.net.pl	3545	171	2954	1	419
3	news.icm.edu.pl	32	0	6	0	26
TOTAL: 3		12254	202	10201	3	1848

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	78
comp.mobile.android	43
it.comp.os.win.windows10	38
it.tlc.cellulari.android	32
it.comp.os.win.windows7	3
it.politica.m5s	2
de.comp.lang.vbclassic	2
it.discussioni.energia	1
alt.binaries.novarip	1
it.comp.virtualizzazione	1
comp.sys.raspberry-pi	1
TOTAL: 11	202

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1186
Binary in non-binary group	54
EMP (phl)	48
Scoring filter (8)	19
Scoring filter (9)	18
Scoring filter (16)	7
Too many newsgroups	3
HTML post	3
Scoring filter (18)	2
hierarchy violation - crosspost outside cl	1
Attached HTML file	1
TOTAL: 11	1342

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	366
	news.nask.pl	137
	news.icm.edu.pl	3
	TOTAL: 3	506
TOTAL: 1		506

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nask	338735	47595	172980	164	56	14%	23:59:57
2	panorama	238022	241	210966	56	231020	0%	23:59:57
3	poznan	8015	117	5615	16	0	1%	23:59:46
4	icm	279452	78	220490	15837	7	0%	23:59:57
5	okapi	0	0	0	0	810	0%	23:57:50
TOTAL: 5		864224	48031	610051	16073	231893	5%	119:57:27

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	24.2 GB	85.3 MB	24.3 GB	294.6 KB/s	533.0 KB	23:59:57
2	panorama	14.4 MB	11.8 MB	26.2 MB	0.3 KB/s	90.4 KB	23:59:57
3	icm	4.0 MB	7.5 GB	7.5 GB	90.7 KB/s	492.1 KB	23:59:57
4	poznan	461.3 KB	42.9 KB	504.1 KB	0.0 KB/s	3.8 KB	23:59:46
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:50
TOTAL: 5		24.2 GB	7.6 GB	31.8 GB	77.1 KB/s	519.7 KB	119:57:27

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	32	39.1 KB	16	0	00:00:21
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 2		289	32	39.1 KB	16	1	00:00:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	577	32	39.1 KB	16	1	00:00:26
2	unresolved	96	0	0.0 KB	0	0	00:00:01
TOTAL: 2		673	32	39.1 KB	16	1	00:00:28

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.516	6.376	00:00:21
mon.man.lodz.pl	1.288	6.332	00:00:04
212.51.192.185	0.440	1.892	00:00:01
isvcs01.man.lodz.pl	0.012	0.012	00:00:00
TOTAL: 4	3.256	14.612	00:00:28

Curious NNRP server explorers [Top 20]:

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

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	22
2	pl.comp.pecet	10
TOTAL: 2		32

Daily Usenet report

Oct 11 04:15:03 -- Oct 12 04:15:02