Daily Usenet report: Jun 2 04:15:04

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Jun 2 09:03:11 newsfeed nnrpd[29277]: SERVER perl filter not defined
Jun 2 22:53:53 newsfeed nnrpd[23290]: SERVER perl filter not defined
Jun 3 04:15:17 newsfeed nnrpd[1398]: web.man.lodz.pl rejected Flushing log and syslog files
Jun 3 04:15:17 newsfeed nnrpd[1399]: web.man.lodz.pl rejected Flushing log and syslog files

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2593841	98.6%	294.8 MB	98.2%
innd	19036	0.7%	3.2 MB	1.1%
nnrpd	9887	0.4%	1.0 MB	0.3%
innfeed	6985	0.3%	1.1 MB	0.4%
TOTAL: 4	2629749	100.0%	300.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2583653	95.8%
Negative hits	69362	2.6%
Positive hits	43747	1.6%
Cache misses	627	0.0%
TOTAL: 4	2697389	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:18.472	0.0%	571	0.000	32.350	587.000
article cleanup	00:00:36.690	0.0%	2593638	0.003	0.014	0.276
article logging	00:01:36.149	0.1%	2593830	0.013	0.037	1.112
article parse	01:19:38.986	5.5%	65549768	0.043	0.073	0.303
article write	00:29:44.044	2.1%	2582468	0.411	0.691	7.389
artlog/artcncl	00:00:00.018	0.0%	548	0.000	0.033	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:02:47.912	0.2%	79079751	0.001	0.002	0.023
hisgrep/artcncl	00:00:05.736	0.0%	530	0.000	10.823	429.000
hishave/artcncl	00:00:03.589	0.0%	571	0.000	6.285	129.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	04:37:59.317	19.3%	2697911	0.207	6.182	45.180
history sync	00:00:00.010	0.0%	292	0.000	0.034	1.000
history write	06:12:10.354	25.8%	2584458	0.043	8.640	68.204
hiswrite/artcncl	00:00:00.505	0.0%	41	0.000	12.317	252.000
idle	03:06:50.846	13.0%	23502567	0.195	0.477	2.978
nntp read	00:41:10.975	2.9%	63320499	0.026	0.039	0.312
overview write	00:00:18.404	0.0%	2582468	0.000	0.007	0.041
perl filter	06:57:42.503	29.0%	2584456	7.518	9.697	36.707
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:08:22.389	0.6%	5205517	0.010	0.097	14.429
TOTAL: 24:00:02.992	23:39:26.899	98.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.191	0.0%	40595	0.000	0.005	1.000
article prepare	00:00:00.016	0.0%	32576	0.000	0.000	0.125
article read	00:00:00.771	0.0%	7659	0.000	0.101	24.800
backlog stats	00:00:00.276	0.0%	279640	0.000	0.001	1.000
callbacks	00:00:00.001	0.0%	1	1.000	1.000	1.000
data read	00:00:03.568	0.0%	174480	0.000	0.020	10.316
data write	00:00:06.247	0.0%	141182	0.000	0.044	4.204
idle	23:59:26.733	100.0%	279640	0.000	308.850	21766.000
status file	00:00:07.173	0.0%	232	1.000	30.918	592.000
TOTAL: 23:59:58.584	23:59:44.976	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:22.382	0.0%	19101	1.106	1.172	7.549
idle	67:16:45.971	100.0%	70006	0.000	3459.789	600221.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:08.631	0.0%	141966	0.000	0.061	27.000
readart	00:00:20.700	0.0%	19370	0.000	1.069	175.000
TOTAL: 67:18:34.127	67:17:37.684	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	538	2578206	2568892	723	8591	99%	535:12:42
2	news.nask.pl	4	18316	6997	10041	1278	38%	24:00:08
3	news.task.gda.pl	13	32462	6166	25043	1253	18%	47:31:06
4	news.icm.edu.pl	30	524	13	403	108	2%	22:31:31
5	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 5		588	2629510	2582070	36210	11230	98%	629:15:27

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	815.5 GB	716.7 MB	743.8 MB	817.0 GB	99%	332.4 KB
2	news.nask.pl	23.7 MB	4.0 MB	4.1 MB	31.8 MB	74%	3.9 KB
3	news.task.gda.pl	11.1 MB	84.4 KB	3.2 MB	14.3 MB	77%	2.0 KB
4	news.icm.edu.pl	194.2 KB	36.6 KB	4.1 MB	4.4 MB	4%	36.9 KB
5	localhost	4.9 KB	0.0 KB	0.0 KB	4.9 KB	100%	2.4 KB
TOTAL: 5		815.6 GB	720.8 MB	755.2 MB	817.0 GB	99%	330.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 2 04:15:04 - 04:59:59	50886	2.0%	18.87	16.6 GB	2.0%	6452.94
Jun 2 05:00:00 - 05:59:59	89032	3.4%	24.73	27.8 GB	3.4%	8085.30
Jun 2 06:00:00 - 06:59:59	98528	3.8%	27.37	32.0 GB	3.9%	9324.49
Jun 2 07:00:00 - 07:59:59	102278	4.0%	28.41	33.2 GB	4.1%	9660.04
Jun 2 08:00:00 - 08:59:59	111619	4.3%	31.01	33.9 GB	4.2%	9879.86
Jun 2 09:00:00 - 09:59:59	111584	4.3%	31.00	33.9 GB	4.2%	9869.79
Jun 2 10:00:00 - 10:59:59	107444	4.2%	29.85	33.4 GB	4.1%	9737.54
Jun 2 11:00:00 - 11:59:59	103759	4.0%	28.82	33.5 GB	4.1%	9763.98
Jun 2 12:00:00 - 12:59:59	109464	4.2%	30.41	35.5 GB	4.4%	10352.73
Jun 2 13:00:00 - 13:59:59	112921	4.4%	31.37	36.1 GB	4.4%	10517.18
Jun 2 14:00:00 - 14:59:59	116803	4.5%	32.45	37.4 GB	4.6%	10882.17
Jun 2 15:00:00 - 15:59:59	119599	4.6%	33.22	37.2 GB	4.6%	10826.37
Jun 2 16:00:00 - 16:59:59	136793	5.3%	38.00	37.6 GB	4.6%	10945.97
Jun 2 17:00:00 - 17:59:59	114615	4.4%	31.84	32.3 GB	4.0%	9395.82
Jun 2 18:00:00 - 18:59:59	105526	4.1%	29.31	32.5 GB	4.0%	9462.42
Jun 2 19:00:00 - 19:59:59	111653	4.3%	31.01	34.0 GB	4.2%	9905.24
Jun 2 20:00:00 - 20:59:59	112936	4.4%	31.37	35.2 GB	4.3%	10251.64
Jun 2 21:00:00 - 21:59:59	106004	4.1%	29.45	33.1 GB	4.1%	9645.66
Jun 2 22:00:00 - 22:59:59	113744	4.4%	31.60	37.0 GB	4.5%	10788.05
Jun 2 23:00:00 - 23:59:59	120000	4.6%	33.33	40.2 GB	4.9%	11720.01
Jun 3 00:00:00 - 00:59:59	102688	4.0%	28.52	32.8 GB	4.0%	9564.22
Jun 3 01:00:00 - 01:59:59	104431	4.0%	29.01	34.9 GB	4.3%	10179.28
Jun 3 02:00:00 - 02:59:59	122631	4.7%	34.06	42.4 GB	5.2%	12357.23
Jun 3 03:00:00 - 03:59:59	75991	2.9%	21.11	25.8 GB	3.2%	7518.64
Jun 3 04:00:00 - 04:15:17	21000	0.8%	22.90	7.2 GB	0.9%	8186.85
TOTAL: 24:00:13	2581929	100.0%	29.88	815.6 GB	100.0%	9896.49

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	8744	263	7890	0	591
2	news.nask.pl	1311	10	1243	1	57
3	news.task.gda.pl	1228	1007	46	3	172
4	news.icm.edu.pl	81	0	3	0	78
TOTAL: 4		11364	1280	9182	4	898

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	131
mailing.freebsd.svn-ports-head	130
uk.railway	127
alt.politics.scorched-earth	118
mailing.freebsd.ports-bugs	115
mailing.openbsd.source-changes	78
it.comp.os.win.windows8	50
mailing.freebsd.svn-src-all	39
mailing.freebsd.svn-src-head	36
uk.rec.cycling.moderated	35
fa.freebsd.cvs-all	35
mailing.unix.samba	27
mailing.openbsd.ports-changes	22
mailing.dragonflybsd.users	21
mailing.freebsd.current	20
fr.usenet.abus.nocem	19
mailing.postfix.users	13
mozilla.dev.tree-management	13
24hoursupport.helpdesk	12
hr.sci.med	11
TOTAL: 77	1280

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

Groups	Count
fr.comp.lang.php	1
fr.bienvenue	1
pl.sci.matematyka	1
fr.comp.applications.libres	1
TOTAL: 4	4

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	313
EMP (fsl)	149
HTML post	101
EMP (md5)	99
Attached HTML file	37
Scoring filter (9)	4
Angle-bracket bot	1
TOTAL: 7	704

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	53013	3445	31492	1084	4	19	6%	24:03:15
2	panorama	43913	2711	37056	629	0	0	6%	23:53:51
3	task	2409	173	1222	7	0	0	7%	21:45:21
4	poznan	14101	52	12320	29	0	0	0%	24:01:46
5	nask	17969	2	13861	0	0	0	0%	24:04:11
6	okapi	0	0	0	0	0	2501	0%	24:00:00
TOTAL: 6		131405	6383	95951	1749	4	2520	4%	141:48:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	210.8 MB	162.3 MB	373.1 MB	4.4 KB/s	84.4 KB	24:03:15
2	panorama	7.2 MB	3.4 MB	10.6 MB	0.1 KB/s	3.3 KB	23:53:51
3	task	367.9 KB	13.0 KB	381.0 KB	0.0 KB/s	2.1 KB	21:45:21
4	poznan	128.9 KB	66.6 KB	195.5 KB	0.0 KB/s	2.4 KB	24:01:46
5	nask	3.7 KB	0.0 KB	3.7 KB	0.0 KB/s	1.9 KB	24:04:11
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		218.5 MB	165.8 MB	384.3 MB	0.8 KB/s	48.4 KB	141:48:24

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	312	723.6 KB	288	0	00:00:16
2	web.man.lodz.pl	290	74	84.7 KB	33	0	00:00:24
3	eci201.neoplus.adsl.tpnet.pl	3	3	6.1 KB	2	0	00:03:46
4	kujawiak.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 4		583	389	814.5 KB	323	2	67:18:32

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	312	723.6 KB	288	0	00:00:16
2	*.man.lodz.pl	676	74	84.7 KB	33	2	00:00:35
3	*.neoplus.adsl.tpnet.pl	3	3	6.1 KB	2	0	00:03:46
4	*.207.15.62.static.jazztel.es	7	0	0.0 KB	0	0	19:58:45
5	*.105.135.22.tvsat364.lodz.pl	1	0	0.0 KB	0	0	00:30:00
6	unresolved	276	0	0.0 KB	0	0	46:44:24
7	*.toya.net.pl	52	0	0.0 KB	0	0	00:00:43
TOTAL: 7		1303	389	814.5 KB	323	2	67:18:32

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	1.012	10.220	46:44:24
82.207.15.62.static.jazztel.es	7.052	18.493	15:58:23
85.207.15.62.static.jazztel.es	1.228	2.620	04:00:22
ip-176.105.135.22.tvsat364.lodz.pl	0.004	0.036	00:30:00
eci201.neoplus.adsl.tpnet.pl	0.012	0.088	00:03:46
staticline41435.toya.net.pl	0.224	2.884	00:00:43
web.man.lodz.pl	2.816	28.896	00:00:24
vegas.cm.p.lodz.pl	1.592	17.052	00:00:16
f-oper-v100.man.lodz.pl	1.456	20.204	00:00:07
david.man.lodz.pl	0.556	7.480	00:00:02
kujawiak.man.lodz.pl	0.016	0.324	00:00:00
TOTAL: 11	15.968	108.297	67:18:32

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
212.191.78.190	276
david.man.lodz.pl	96
staticline41435.toya.net.pl	52
85.207.15.62.static.jazztel.es	7
ip-176.105.135.22.tvsat364.lodz.pl	1
TOTAL: 6	720

NNRP client timeouts [Top 20]:

System	Conn	Peer
212.191.78.190	2	0
85.207.15.62.static.jazztel.es	1	1
82.207.15.62.static.jazztel.es	1	0
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 4	5	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	315	81.0%
2	pl	74	19.0%
TOTAL: 2		389	100.0%

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

Newsgroup		Count
1	lodman.info	315
2	pl.comp.pecet	60
3	pl.comp.os.ms-windows.winnt	12
4	pl.internet.polip	2
TOTAL: 4		389

Daily Usenet report

Jun 2 04:15:04 -- Jun 3 04:15:17