Daily Usenet report: Nov 10 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Nov 10 05:13:28 newsfeed overchan[2236]: input line too long, skipping
Nov 10 06:04:51 newsfeed overchan[2236]: input line too long, skipping
Nov 10 06:33:19 newsfeed overchan[2236]: input line too long, skipping
Nov 10 11:19:00 newsfeed nnrpd[18053]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	795263	96.6%	89.7 MB	95.9%
innd	14732	1.8%	2.2 MB	2.4%
nnrpd	7160	0.9%	746.3 KB	0.8%
innfeed	6479	0.8%	924.1 KB	1.0%
overchan	3	0.0%	0.5 KB	0.0%
TOTAL: 5	823637	100.0%	93.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	791007	92.8%
Negative hits	42684	5.0%
Positive hits	18240	2.1%
Cache misses	138	0.0%
TOTAL: 4	852069	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:09.009	0.0%	341	0.000	26.419	598.000
article cleanup	00:00:13.497	0.0%	795069	0.000	0.017	0.049
article logging	00:00:22.379	0.0%	795190	0.000	0.028	0.090
article parse	00:28:27.876	2.0%	67303487	0.009	0.025	0.060
article write	00:06:51.148	0.5%	786757	0.149	0.523	5.923
artlog/artcncl	00:00:00.006	0.0%	329	0.000	0.018	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:01:22.427	0.1%	72117560	0.000	0.001	0.004
hisgrep/artcncl	00:00:01.351	0.0%	316	0.000	4.275	217.000
hishave/artcncl	00:00:01.129	0.0%	341	0.000	3.311	44.053
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:59:45.090	4.1%	852992	0.011	4.203	12.570
history sync	00:00:00.029	0.0%	446	0.000	0.065	1.000
history write	01:29:31.618	6.2%	792174	0.690	6.781	25.341
hiswrite/artcncl	00:00:00.088	0.0%	25	0.000	3.520	9.000
idle	18:20:58.670	76.5%	50988086	0.342	1.296	9.260
nntp read	00:28:14.912	2.0%	66748792	0.014	0.025	0.042
overview write	00:00:05.154	0.0%	786757	0.000	0.007	0.030
perl filter	01:45:32.589	7.3%	792173	2.870	7.994	11.419
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:01:40.127	0.1%	1605415	0.021	0.062	0.137
TOTAL: 23:59:50.574	23:43:17.099	98.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.103	0.0%	31909	0.000	0.003	0.200
article prepare	00:00:00.003	0.0%	14602	0.000	0.000	0.250
article read	00:00:00.331	0.0%	3618	0.000	0.091	3.000
backlog stats	00:00:00.108	0.0%	214186	0.000	0.001	1.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.362	0.0%	135729	0.000	0.010	2.000
data write	00:00:03.829	0.0%	106192	0.000	0.036	2.000
idle	23:59:29.248	100.0%	214186	0.000	403.244	30095.000
status file	00:00:00.983	0.0%	192	0.000	5.120	151.000
TOTAL: 23:59:40.875	23:59:35.967	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	17:22:29.334	99.9%	265026	0.000	236.012	16235.071
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:08.259	0.0%	531799	0.000	0.016	5.222
readart	00:00:00.669	0.0%	360	0.000	1.858	205.000
TOTAL: 17:23:07.718	17:22:38.262	100.0%	-	-	-	-

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	418	791475	783455	559	7461	98%	182:08:41
2	news.nask.pl	2	18367	3144	14491	732	17%	24:10:53
3	news.icm.edu.pl	47	360	44	218	98	12%	16:25:39
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		469	810203	786644	15268	8291	97%	222:45:13

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	222.1 GB	16.5 MB	630.5 MB	222.7 GB	99%	295.2 KB
2	news.nask.pl	15.4 MB	1.8 MB	2.1 MB	19.4 MB	79%	5.1 KB
3	news.icm.edu.pl	1.1 MB	57.6 KB	1.8 MB	3.0 MB	37%	21.6 KB
4	localhost	1.2 KB	0.0 KB	0.0 KB	1.2 KB	100%	1.2 KB
TOTAL: 4		222.1 GB	18.4 MB	634.5 MB	222.7 GB	99%	293.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 10 04:15:02 - 04:59:59	49883	6.3%	18.49	17.1 GB	7.7%	6661.35
Nov 10 05:00:00 - 05:59:59	70221	8.9%	19.51	23.3 GB	10.5%	6775.79
Nov 10 06:00:00 - 06:59:59	70941	9.0%	19.71	23.4 GB	10.6%	6824.99
Nov 10 07:00:00 - 07:59:59	47531	6.0%	13.20	15.7 GB	7.1%	4568.67
Nov 10 08:00:00 - 08:59:59	65747	8.4%	18.26	22.5 GB	10.1%	6545.01
Nov 10 09:00:00 - 09:59:59	51705	6.6%	14.36	15.6 GB	7.0%	4536.67
Nov 10 10:00:00 - 10:59:59	13763	1.7%	3.82	2.6 GB	1.2%	763.87
Nov 10 11:00:00 - 11:59:59	12368	1.6%	3.44	2.8 GB	1.3%	814.65
Nov 10 12:00:00 - 12:59:59	12929	1.6%	3.59	2.7 GB	1.2%	780.45
Nov 10 13:00:00 - 13:59:59	12564	1.6%	3.49	2.4 GB	1.1%	702.86
Nov 10 14:00:00 - 14:59:59	11127	1.4%	3.09	2.0 GB	0.9%	586.00
Nov 10 15:00:00 - 15:59:59	10070	1.3%	2.80	1.6 GB	0.7%	476.31
Nov 10 16:00:00 - 16:59:59	10079	1.3%	2.80	1.7 GB	0.7%	481.38
Nov 10 17:00:00 - 17:59:59	11070	1.4%	3.08	2.1 GB	1.0%	616.58
Nov 10 18:00:00 - 18:59:59	11430	1.5%	3.17	2.0 GB	0.9%	586.44
Nov 10 19:00:00 - 19:59:59	13040	1.7%	3.62	2.4 GB	1.1%	688.42
Nov 10 20:00:00 - 20:59:59	12698	1.6%	3.53	2.4 GB	1.1%	698.78
Nov 10 21:00:00 - 21:59:59	15833	2.0%	4.40	2.6 GB	1.2%	758.06
Nov 10 22:00:00 - 22:59:59	17499	2.2%	4.86	2.4 GB	1.1%	691.26
Nov 10 23:00:00 - 23:59:59	22216	2.8%	6.17	2.6 GB	1.2%	758.19
Nov 11 00:00:00 - 00:59:59	51424	6.5%	14.28	13.6 GB	6.1%	3962.80
Nov 11 01:00:00 - 01:59:59	64175	8.2%	17.83	18.2 GB	8.2%	5298.93
Nov 11 02:00:00 - 02:59:59	62336	7.9%	17.32	18.7 GB	8.4%	5451.50
Nov 11 03:00:00 - 03:59:59	55850	7.1%	15.51	18.4 GB	8.3%	5365.36
Nov 11 04:00:00 - 04:15:02	9998	1.3%	11.08	3.3 GB	1.5%	3793.45
TOTAL: 24:00:00	786497	100.0%	9.10	222.0 GB	100.0%	2694.82

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	7575	314	2222	1	5038
2	news.nask.pl	751	49	671	5	26
3	news.icm.edu.pl	111	0	3	0	108
TOTAL: 3		8437	363	2896	6	5172

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	181
alt.sex.telephones	42
it.tlc.cellulari.android	31
comp.mobile.android	22
comp.sys.raspberry-pi	17
hr.alt.cellular.gsm.iphone	16
comp.mobile.ipad	12
it.comp.os.win.windows8	9
hr.alt.cellular.gsm.android	7
it.comp.os.win.windows7	6
hr.ponuda.hardver.komponente	5
uk.rec.cycling.moderated	4
rec.arts.tv.x-factor	2
de.comp.lang.vbclassic	2
hr.rec.glazba.hifi	2
it.discussioni.energia	2
hr.ponuda.hardver.periferije	1
de.comp.office-pakete.ms-office.excel	1
nl.comp.os.linux.techniek	1
TOTAL: 19	363

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

Groups	Count
fido7.ru.guitar.soft	2
pl.sci.historia	2
pl.sci.matematyka	1
bit.listserv.catholic	1
TOTAL: 4	6

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	4928
EMP (md5)	120
EMP (fsl)	1
Attached HTML file	1
TOTAL: 4	5050

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	32505	1676	30042	220	1	0	5%	24:03:32
2	icm	38432	810	29346	663	1	10	2%	23:55:56
3	nask	27065	221	16067	46	1	0	0%	24:00:45
4	poznan	4223	6	2947	4	0	0	0%	24:00:17
5	okapi	0	0	0	0	0	2834	0%	24:00:01
TOTAL: 5		102225	2713	78402	933	3	2844	2%	120:00:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	93.5 MB	209.9 MB	303.5 MB	3.6 KB/s	211.0 KB	23:55:56
2	nask	24.5 MB	10.4 MB	34.9 MB	0.4 KB/s	133.8 KB	24:00:45
3	panorama	6.4 MB	1.6 MB	7.9 MB	0.1 KB/s	4.3 KB	24:03:32
4	poznan	49.3 KB	13.2 KB	62.5 KB	0.0 KB/s	6.2 KB	24:00:17
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		124.4 MB	221.9 MB	346.3 MB	0.8 KB/s	97.3 KB	120:00:31

Backlog files shrunk by innfeed:

Server	Size
okapi	488.4 KB
TOTAL: 1	488.4 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	300	405.2 KB	288	0	00:00:07
2	web.man.lodz.pl	288	56	52.6 KB	26	0	00:00:25
3	ip-176.105.135.22.tvsat364.lodz.pl	2	4	7.7 KB	1	0	00:03:57
4	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 4		579	360	465.5 KB	315	1	17:23:07

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	300	405.2 KB	288	0	00:00:07
2	*.man.lodz.pl	673	56	52.6 KB	26	1	00:00:31
3	*.105.135.22.tvsat364.lodz.pl	2	4	7.7 KB	1	0	00:03:57
4	*.191.14.62.static.jazztel.es	2	0	0.0 KB	0	0	15:52:53
5	*.elsnet.pl	6	0	0.0 KB	0	0	00:00:33
6	*.207.15.62.static.jazztel.es	2	0	0.0 KB	0	0	01:24:59
7	*.toya.net.pl	79	0	0.0 KB	0	0	00:00:05
TOTAL: 7		1052	360	465.5 KB	315	1	17:23:07

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
251.191.14.62.static.jazztel.es	10.058	14.729	15:52:53
70.207.15.62.static.jazztel.es	1.100	1.587	01:24:59
ip-176.105.135.22.tvsat364.lodz.pl	0.012	0.018	00:03:57
host227.elsnet.pl	0.003	0.074	00:00:33
web.man.lodz.pl	1.076	2.823	00:00:25
pc-skrzep2.cm.p.lodz.pl	1.081	2.848	00:00:07
staticline41435.toya.net.pl	0.320	0.735	00:00:05
mon.man.lodz.pl	0.937	2.742	00:00:04
david.man.lodz.pl	0.302	0.904	00:00:01
isvcs01.man.lodz.pl	0.016	0.004	00:00:00
TOTAL: 10	14.905	26.464	17:23:07

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	79
host227.elsnet.pl	6
70.207.15.62.static.jazztel.es	2
251.191.14.62.static.jazztel.es	2
TOTAL: 6	473

NNRP client timeouts [Top 20]:

System	Conn	Peer
70.207.15.62.static.jazztel.es	1	1
251.191.14.62.static.jazztel.es	1	0
TOTAL: 2	2	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	300	83.3%
2	pl	60	16.7%
TOTAL: 2		360	100.0%

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

Newsgroup		Count
1	lodman.info	300
2	pl.comp.pecet	54
3	pl.soc.prawo	4
4	pl.comp.os.ms-windows.winnt	2
TOTAL: 4		360

Daily Usenet report

Nov 10 04:15:02 -- Nov 11 04:15:02