Daily Usenet report: Aug 6 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Aug 6 10:35:44 newsfeed nnrpd[28902]: SERVER perl filter not defined
Aug 6 23:02:30 newsfeed nnrpd[21364]: SERVER perl filter not defined
Aug 6 23:20:39 newsfeed nnrpd[21865]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1777696	97.7%	202.9 MB	97.2%
innd	27950	1.5%	4.1 MB	2.0%
nnrpd	7228	0.4%	757.2 KB	0.4%
innfeed	6835	0.4%	1008.7 KB	0.5%
TOTAL: 4	1819709	100.0%	208.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1772335	94.0%
Negative hits	91276	4.8%
Positive hits	20717	1.1%
Cache misses	221	0.0%
TOTAL: 4	1884549	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:12.389	0.0%	532	0.000	23.288	894.000
article cleanup	00:00:29.645	0.0%	1777470	0.000	0.017	0.036
article logging	00:00:51.598	0.1%	1777643	0.013	0.029	0.361
article parse	01:10:10.727	4.9%	122010509	0.010	0.035	0.057
article write	00:17:04.718	1.2%	1760736	0.298	0.582	2.355
artlog/artcncl	00:00:00.015	0.0%	517	0.000	0.029	1.000
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:02:58.899	0.2%	132837314	0.000	0.001	0.003
hisgrep/artcncl	00:00:02.147	0.0%	378	0.000	5.680	129.000
hishave/artcncl	00:00:00.650	0.0%	532	0.000	1.222	18.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:13:24.943	5.1%	1885894	0.010	2.336	8.699
history sync	00:00:00.016	0.0%	291	0.000	0.055	1.000
history write	03:46:55.259	15.8%	1773517	0.048	7.677	25.338
hiswrite/artcncl	00:00:01.573	0.0%	154	0.000	10.214	248.000
idle	11:33:19.834	48.1%	74303057	0.257	0.560	1.074
nntp read	01:02:05.231	4.3%	120545862	0.015	0.031	0.043
overview write	00:00:11.739	0.0%	1760736	0.000	0.007	0.017
perl filter	04:10:18.724	17.4%	1773514	5.136	8.468	11.061
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:08.279	0.3%	3559922	0.008	0.070	0.095
TOTAL: 24:00:27.253	23:22:16.386	97.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.140	0.0%	38451	0.000	0.004	0.120
article prepare	00:00:00.014	0.0%	31166	0.000	0.000	0.250
article read	00:00:00.854	0.0%	6997	0.000	0.122	15.000
backlog stats	00:00:00.203	0.0%	299834	0.000	0.001	1.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.173	0.0%	167834	0.000	0.013	1.000
data write	00:00:07.345	0.0%	150741	0.000	0.049	2.000
idle	24:00:07.502	100.0%	299834	0.000	288.184	28115.000
status file	00:00:00.160	0.0%	167	0.000	0.958	22.000
TOTAL: 24:00:24.878	24:00:18.391	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	07:37:49.463	99.8%	173626	0.000	158.211	450130.250
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:06.262	0.0%	349179	0.000	0.018	0.889
readart	00:00:01.815	0.0%	447	0.000	4.060	174.000
TOTAL: 07:38:37.057	07:37:57.540	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	816	1771869	1753708	2492	15669	98%	371:22:05
2	news.nask.pl	5	21343	6535	13797	1011	30%	24:13:17
3	news.icm.edu.pl	39	320	6	277	37	1%	19:10:06
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		864	1793535	1760252	16566	16717	98%	414:45:28

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	565.5 GB	44.6 MB	1.7 GB	567.2 GB	99%	336.1 KB
2	news.nask.pl	69.9 MB	2.8 MB	3.0 MB	75.7 MB	92%	10.3 KB
3	news.icm.edu.pl	262.4 KB	0.0 KB	417.9 KB	680.2 KB	38%	15.8 KB
4	localhost	3.8 KB	0.0 KB	0.0 KB	3.8 KB	100%	1.3 KB
TOTAL: 4		565.5 GB	47.4 MB	1.7 GB	567.3 GB	99%	334.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 6 04:15:02 - 04:59:59	48832	2.8%	18.10	18.9 GB	3.3%	7335.13
Aug 6 05:00:00 - 05:59:59	70912	4.0%	19.70	26.7 GB	4.7%	7764.04
Aug 6 06:00:00 - 06:59:59	79802	4.5%	22.17	24.1 GB	4.3%	7025.80
Aug 6 07:00:00 - 07:59:59	100643	5.7%	27.96	30.3 GB	5.4%	8834.95
Aug 6 08:00:00 - 08:59:59	100067	5.7%	27.80	29.5 GB	5.2%	8584.21
Aug 6 09:00:00 - 09:59:59	95601	5.4%	26.56	28.6 GB	5.1%	8343.61
Aug 6 10:00:00 - 10:59:59	94433	5.4%	26.23	28.6 GB	5.1%	8319.54
Aug 6 11:00:00 - 11:59:59	93087	5.3%	25.86	26.3 GB	4.7%	7666.89
Aug 6 12:00:00 - 12:59:59	98724	5.6%	27.42	27.5 GB	4.9%	7998.74
Aug 6 13:00:00 - 13:59:59	100974	5.7%	28.05	29.8 GB	5.3%	8671.49
Aug 6 14:00:00 - 14:59:59	103483	5.9%	28.75	29.2 GB	5.2%	8493.82
Aug 6 15:00:00 - 15:59:59	86346	4.9%	23.98	26.6 GB	4.7%	7744.18
Aug 6 16:00:00 - 16:59:59	68143	3.9%	18.93	24.9 GB	4.4%	7255.68
Aug 6 17:00:00 - 17:59:59	79210	4.5%	22.00	26.1 GB	4.6%	7610.33
Aug 6 18:00:00 - 18:59:59	54615	3.1%	15.17	18.3 GB	3.2%	5342.03
Aug 6 19:00:00 - 19:59:59	39176	2.2%	10.88	13.5 GB	2.4%	3925.23
Aug 6 20:00:00 - 20:59:59	36550	2.1%	10.15	12.1 GB	2.1%	3534.94
Aug 6 21:00:00 - 21:59:59	38931	2.2%	10.81	13.3 GB	2.3%	3869.74
Aug 6 22:00:00 - 22:59:59	41141	2.3%	11.43	14.4 GB	2.6%	4205.68
Aug 6 23:00:00 - 23:59:59	39444	2.2%	10.96	14.3 GB	2.5%	4170.73
Aug 7 00:00:00 - 00:59:59	67761	3.8%	18.82	23.0 GB	4.1%	6708.76
Aug 7 01:00:00 - 01:59:59	54370	3.1%	15.10	19.7 GB	3.5%	5725.33
Aug 7 02:00:00 - 02:59:59	75502	4.3%	20.97	27.5 GB	4.9%	8016.63
Aug 7 03:00:00 - 03:59:59	75501	4.3%	20.97	26.1 GB	4.6%	7587.69
Aug 7 04:00:00 - 04:15:02	17022	1.0%	18.87	6.2 GB	1.1%	7190.16
TOTAL: 24:00:00	1760270	100.0%	20.37	565.4 GB	100.0%	6862.45

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	15849	219	3002	0	12628
2	news.nask.pl	1023	28	953	1	41
3	news.icm.edu.pl	37	0	0	0	37
TOTAL: 3		16909	247	3955	1	12706

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	70
comp.mobile.ipad	49
comp.mobile.android	30
it.comp.os.win.windows8	23
it.tlc.cellulari.android	19
comp.sys.raspberry-pi	18
nl.wetenschap.regulier	4
nl.comp.os.linux.techniek	4
uk.rec.cycling.moderated	4
de.comp.office-pakete.ms-office.outlook	3
de.comp.lang.php	3
alt.sex.telephones	3
nl.comp.sys.android	3
it.comp.os.win.windows7	3
it.discussioni.energia	2
hr.ponuda.hardver.komponente	2
hr.ponuda.hardver.konfiguracije	2
gmane.comp.gis.openstreetmap.devel	1
de.comp.office-pakete.ms-office.word	1
de.comp.office-pakete.ms-office.excel	1
TOTAL: 22	247

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

Groups	Count
pl.sci.historia	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	12450
EMP (md5)	55
EMP (fsl)	19
HTML post	5
Scoring filter (12)	1
TOTAL: 5	12530

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	39818	2073	35876	526	0	0	5%	24:04:25
2	nask	29980	1138	17483	815	0	0	3%	23:54:43
3	icm	61116	655	32055	2405	3	5	1%	24:00:02
4	poznan	8341	103	5953	57	0	0	1%	24:00:00
5	okapi	0	0	0	0	0	2457	0%	24:00:02
TOTAL: 5		139255	3969	91367	3803	3	2462	2%	119:59:12

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	141.6 MB	296.3 MB	437.9 MB	5.2 KB/s	229.6 KB	23:54:43
2	icm	32.2 MB	364.7 MB	396.9 MB	4.7 KB/s	132.8 KB	24:00:02
3	panorama	17.5 MB	13.4 MB	30.9 MB	0.4 KB/s	12.2 KB	24:04:25
4	poznan	305.9 KB	101.0 KB	406.9 KB	0.0 KB/s	2.5 KB	24:00:00
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		191.5 MB	674.5 MB	866.1 MB	2.1 KB/s	114.1 KB	119:59:12

Backlog files shrunk by innfeed:

Server	Size
okapi	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	324	437.2 KB	288	0	00:00:09
2	web.man.lodz.pl	288	78	77.7 KB	35	0	00:00:31
3	lze200.lze.lodz.pl	2	40	83.8 KB	2	0	00:17:12
4	194.33.77.50	4	4	5.2 KB	1	0	00:39:23
5	pc-vicki.man.lodz.pl	1	1	1.2 KB	1	0	00:30:02
6	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 6		586	447	605.0 KB	327	3	07:38:36

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	324	437.2 KB	288	0	00:00:09
2	*.man.lodz.pl	676	79	78.9 KB	36	3	00:30:39
3	*.lze.lodz.pl	2	40	83.8 KB	2	0	00:17:12
4	unresolved	6	4	5.2 KB	1	0	00:39:29
5	*.205.15.62.static.jazztel.es	2	0	0.0 KB	0	0	06:10:59
6	*.toya.net.pl	82	0	0.0 KB	0	0	00:00:06
TOTAL: 6		1056	447	605.0 KB	327	3	07:38:36

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
137.205.15.62.static.jazztel.es	8.007	11.809	06:10:59
194.33.77.50	0.022	0.070	00:39:23
pc-vicki.man.lodz.pl	0.006	0.022	00:30:02
lze200.lze.lodz.pl	0.017	0.047	00:17:12
web.man.lodz.pl	1.490	4.930	00:00:31
pc-skrzep2.cm.p.lodz.pl	1.471	4.872	00:00:09
staticline41435.toya.net.pl	0.428	1.380	00:00:06
212.51.203.199	0.010	0.031	00:00:06
mon.man.lodz.pl	1.394	4.510	00:00:04
david.man.lodz.pl	0.481	1.558	00:00:01
isvcs01.man.lodz.pl	0.026	0.057	00:00:00
TOTAL: 11	13.352	29.286	07:38:36

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	82
137.205.15.62.static.jazztel.es	2
212.51.203.199	2
TOTAL: 5	470

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-vicki.man.lodz.pl	1	0
194.33.77.50	1	0
TOTAL: 2	2	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	328	73.4%
2	pl	119	26.6%
TOTAL: 2		447	100.0%

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

Newsgroup		Count
1	lodman.info	328
2	pl.comp.os.ms-windows.winnt	76
3	pl.misc.telefonia.gsm	30
4	pl.comp.pecet	12
5	pl.sci.medycyna	1
TOTAL: 5		447

Daily Usenet report

Aug 6 04:15:02 -- Aug 7 04:15:02