Daily Usenet report: Apr 30 04:15:01

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Apr 30 08:25:45 newsfeed nnrpd[14767]: SERVER perl filter not defined
Apr 30 08:44:18 newsfeed overchan[2426]: input line too long, skipping
Apr 30 19:24:24 newsfeed overchan[2426]: input line too long, skipping
Apr 30 19:46:50 newsfeed nnrpd[4908]: SERVER perl filter not defined
Apr 30 19:52:20 newsfeed nnrpd[5142]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1209472	97.9%	139.0 MB	97.4%
innd	11885	1.0%	2.0 MB	1.4%
innfeed	7455	0.6%	1.1 MB	0.7%
nnrpd	7125	0.6%	750.7 KB	0.5%
overchan	2	0.0%	0.3 KB	0.0%
TOTAL: 5	1235939	100.0%	142.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1205132	97.8%
Positive hits	15907	1.3%
Negative hits	11546	0.9%
Cache misses	150	0.0%
TOTAL: 4	1232735	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.657	0.0%	267	0.000	6.206	349.000
article cleanup	00:00:14.472	0.0%	1208377	0.000	0.012	0.056
article logging	00:00:38.905	0.0%	1208574	0.000	0.032	0.110
article parse	00:28:19.903	2.0%	63590861	0.015	0.027	0.046
article write	00:10:48.740	0.8%	1205592	0.141	0.538	1.455
artlog/artcncl	00:00:00.003	0.0%	267	0.000	0.011	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:54.954	0.1%	71303355	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.650	0.0%	264	0.000	2.462	291.000
hishave/artcncl	00:00:00.033	0.0%	267	0.000	0.124	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:06:31.069	0.5%	1233521	0.049	0.317	4.483
history sync	00:00:00.020	0.0%	465	0.000	0.043	1.000
history write	00:14:13.927	1.0%	1206161	0.126	0.708	9.482
hiswrite/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
idle	19:33:02.310	81.5%	54118698	0.475	1.301	48.094
nntp read	00:25:18.618	1.8%	62766239	0.012	0.024	0.038
overview write	00:00:08.294	0.0%	1205592	0.000	0.007	0.062
perl filter	02:40:34.104	11.2%	1206160	4.490	7.987	10.064
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:32.536	0.2%	2440643	0.040	0.062	0.146
TOTAL: 23:59:44.434	23:43:20.195	98.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.138	0.0%	29478	0.000	0.005	0.250
article prepare	00:00:00.010	0.0%	21912	0.000	0.000	0.083
article read	00:00:00.609	0.0%	5187	0.000	0.117	1.000
backlog stats	00:00:00.144	0.0%	249373	0.000	0.001	0.017
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.636	0.0%	142952	0.000	0.011	1.000
data write	00:00:05.120	0.0%	118721	0.000	0.043	9.000
idle	24:00:00.627	100.0%	249373	0.000	346.471	15985.000
status file	00:00:00.171	0.0%	200	0.000	0.855	3.000
TOTAL: 24:00:14.466	24:00:08.455	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	03:58:27.788	99.9%	4374	0.000	3271.099	594763.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.367	0.0%	10846	0.000	0.034	3.667
readart	00:00:00.244	0.0%	544	0.000	0.449	3.700
TOTAL: 03:58:45.865	03:58:28.399	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	357	1206092	1203311	273	2508	99%	125:58:42
2	news.nask.pl	2	16142	2645	13255	242	16%	24:22:18
3	news.icm.edu.pl	42	288	31	218	39	10%	18:55:46
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		405	1222525	1205990	13746	2789	98%	169:16:46

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	377.8 GB	9.2 MB	21.3 MB	377.8 GB	99%	328.5 KB
2	news.nask.pl	10.4 MB	782.7 KB	842.9 KB	12.0 MB	86%	4.3 KB
3	news.icm.edu.pl	955.9 KB	40.3 KB	508.1 KB	1.5 MB	63%	21.5 KB
4	localhost	5.1 KB	0.0 KB	0.0 KB	5.1 KB	100%	1.7 KB
TOTAL: 4		377.8 GB	10.0 MB	22.6 MB	377.8 GB	99%	327.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 30 04:15:01 - 04:59:59	42198	3.5%	15.63	16.7 GB	4.4%	6503.14
Apr 30 05:00:00 - 05:59:59	68138	5.6%	18.93	26.4 GB	7.0%	7677.20
Apr 30 06:00:00 - 06:59:59	77181	6.4%	21.44	26.4 GB	7.0%	7685.61
Apr 30 07:00:00 - 07:59:59	71920	6.0%	19.98	26.7 GB	7.1%	7772.93
Apr 30 08:00:00 - 08:59:59	15526	1.3%	4.31	4.3 GB	1.1%	1239.44
Apr 30 09:00:00 - 09:59:59	12210	1.0%	3.39	1.4 GB	0.4%	405.47
Apr 30 10:00:00 - 10:59:59	9028	0.7%	2.51	1.2 GB	0.3%	344.01
Apr 30 11:00:00 - 11:59:59	9438	0.8%	2.62	1.4 GB	0.4%	406.92
Apr 30 12:00:00 - 12:59:59	11167	0.9%	3.10	1.5 GB	0.4%	442.23
Apr 30 13:00:00 - 13:59:59	11027	0.9%	3.06	1.8 GB	0.5%	527.13
Apr 30 14:00:00 - 14:59:59	11769	1.0%	3.27	1.8 GB	0.5%	518.02
Apr 30 15:00:00 - 15:59:59	68571	5.7%	19.05	23.4 GB	6.2%	6825.89
Apr 30 16:00:00 - 16:59:59	51574	4.3%	14.33	18.0 GB	4.8%	5236.26
Apr 30 17:00:00 - 17:59:59	56266	4.7%	15.63	18.3 GB	4.8%	5332.65
Apr 30 18:00:00 - 18:59:59	72753	6.0%	20.21	23.1 GB	6.1%	6728.70
Apr 30 19:00:00 - 19:59:59	64226	5.3%	17.84	18.0 GB	4.8%	5246.16
Apr 30 20:00:00 - 20:59:59	91560	7.6%	25.43	27.3 GB	7.2%	7963.36
Apr 30 21:00:00 - 21:59:59	73207	6.1%	20.34	24.8 GB	6.6%	7236.99
Apr 30 22:00:00 - 22:59:59	13504	1.1%	3.75	2.4 GB	0.6%	713.24
Apr 30 23:00:00 - 23:59:59	12228	1.0%	3.40	2.0 GB	0.5%	578.78
May 1 00:00:00 - 00:59:59	60206	5.0%	16.72	17.8 GB	4.7%	5194.71
May 1 01:00:00 - 01:59:59	94176	7.8%	26.16	29.1 GB	7.7%	8466.86
May 1 02:00:00 - 02:59:59	96515	8.0%	26.81	29.4 GB	7.8%	8568.26
May 1 03:00:00 - 03:59:59	89632	7.4%	24.90	27.6 GB	7.3%	8047.42
May 1 04:00:00 - 04:15:02	22203	1.8%	24.62	6.9 GB	1.8%	8050.22
TOTAL: 24:00:01	1206223	100.0%	13.96	377.8 GB	100.0%	4585.40

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	2692	280	1998	8	406
2	news.nask.pl	250	9	217	4	20
3	news.icm.edu.pl	40	0	1	0	39
TOTAL: 3		2982	289	2216	12	465

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	113
it.tlc.cellulari.android	87
comp.mobile.ipad	44
uk.rec.cycling.moderated	9
de.comp.lang.vbclassic	6
nl.actueel	6
comp.sys.raspberry-pi	4
hr.alt.cellular.gsm.android	4
it.discussioni.energia	4
it.comp.os.linux.ubuntu	3
comp.mobile.android	2
it.comp.virtualizzazione	1
de.rec.sf.startrek	1
nl.comp.sys.android	1
nl.comp.os.linux.techniek	1
it.comp.os.win.windows7	1
hr.ponuda.hardver.komponente	1
it.comp.os.win.windows8	1
TOTAL: 18	289

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

Groups	Count
pl.praca.oferowana	10
bit.listserv.catholic	1
pl.sci.historia	1
TOTAL: 3	12

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	219
EMP (md5)	43
Scoring filter (10)	2
Scoring filter (9)	1
Scoring filter (11)	1
Attached HTML file	1
TOTAL: 6	267

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	38327	1909	27362	318	0	4%	24:07:55
2	icm	40447	931	26340	1375	16	2%	23:52:56
3	nask	27574	128	14383	736	0	0%	24:03:41
4	poznan	3992	47	2551	34	0	1%	23:58:17
5	okapi	0	0	0	0	2460	0%	24:00:04
TOTAL: 5		110340	3015	70636	2463	2476	2%	120:02:53

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	6.3 MB	935.4 KB	7.2 MB	0.1 KB/s	3.3 KB	24:07:55
2	icm	4.6 MB	251.1 MB	255.7 MB	3.0 KB/s	113.6 KB	23:52:56
3	nask	550.9 KB	179.8 MB	180.4 MB	2.1 KB/s	213.8 KB	24:03:41
4	poznan	343.8 KB	56.0 KB	399.8 KB	0.0 KB/s	4.9 KB	23:58:17
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:04
TOTAL: 5		11.8 MB	431.9 MB	443.7 MB	1.1 KB/s	82.9 KB	120:02:53

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	324	553.7 KB	288	0	00:00:07
2	pc-212-51-218-225.p.lodz.pl	10	104	226.8 KB	10	0	03:08:19
3	web.man.lodz.pl	289	52	51.0 KB	23	0	00:00:32
4	lze200.lze.lodz.pl	2	40	75.8 KB	6	0	00:12:40
5	dmcs2.p.lodz.pl	2	24	59.9 KB	4	0	00:34:32
6	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 6		594	544	967.2 KB	331	3	03:58:45

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	324	553.7 KB	288	0	00:00:07
2	*.p.lodz.pl	12	128	286.7 KB	14	0	03:42:51
3	*.man.lodz.pl	676	52	51.0 KB	23	3	00:00:37
4	*.lze.lodz.pl	2	40	75.8 KB	6	0	00:12:40
5	*.plk.prest.pl	1	0	0.0 KB	0	0	00:02:24
6	*.toya.net.pl	50	0	0.0 KB	0	0	00:00:03
TOTAL: 6		1029	544	967.2 KB	331	3	03:58:45

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-51-218-225.p.lodz.pl	0.053	0.171	03:08:19
dmcs2.p.lodz.pl	0.011	0.032	00:34:32
lze200.lze.lodz.pl	0.008	0.052	00:12:40
ftth178-25-4.plk.prest.pl	0.027	0.019	00:02:24
web.man.lodz.pl	1.097	4.706	00:00:32
pc-skrzep2.cm.p.lodz.pl	1.110	4.192	00:00:07
mon.man.lodz.pl	1.056	4.148	00:00:03
staticline41435.toya.net.pl	0.175	0.716	00:00:03
david.man.lodz.pl	0.329	1.339	00:00:01
isvcs01.man.lodz.pl	0.019	0.060	00:00:00
TOTAL: 10	3.885	15.435	03:58:45

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	50
ftth178-25-4.plk.prest.pl	1
TOTAL: 4	435

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	2	0
dmcs2.p.lodz.pl	1	0
TOTAL: 2	3	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	324	59.6%
2	pl	220	40.4%
TOTAL: 2		544	100.0%

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

Newsgroup		Count
1	lodman.info	324
2	pl.misc.elektronika	108
3	pl.comp.pecet	63
4	pl.misc.kolej	20
5	pl.comp.os.ms-windows.winnt	9
6	pl.comp.os.linux	8
7	pl.rec.kuchnia	4
8	pl.internet.polip	4
9	pl.misc.telefonia.gsm	3
10	pl.news.admin	1
TOTAL: 10		544

Daily Usenet report

Apr 30 04:15:01 -- May 1 04:15:02