Daily Usenet report: Nov 29 04:15:03

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Nov 29 08:19:44 newsfeed nnrpd[16099]: SERVER perl filter not defined
Nov 29 08:26:56 newsfeed nnrpd[16384]: SERVER perl filter not defined
Nov 29 09:04:33 newsfeed nnrpd[17664]: SERVER perl filter not defined
Nov 29 09:37:13 newsfeed nnrpd[18701]: SERVER perl filter not defined
Nov 29 11:07:17 newsfeed nnrpd[21689]: SERVER perl filter not defined
Nov 29 12:22:41 newsfeed nnrpd[24276]: SERVER perl filter not defined
Nov 29 12:24:17 newsfeed nnrpd[24283]: SERVER perl filter not defined
Nov 29 16:21:59 newsfeed nnrpd[32190]: SERVER perl filter not defined
Nov 30 02:10:49 newsfeed nnrpd[19223]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1427164	98.2%	165.3 MB	97.7%
innd	13119	0.9%	2.2 MB	1.3%
nnrpd	6939	0.5%	728.9 KB	0.4%
innfeed	6743	0.5%	989.8 KB	0.6%
TOTAL: 4	1453965	100.0%	169.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1423365	97.4%
Negative hits	21224	1.5%
Positive hits	16158	1.1%
Cache misses	117	0.0%
TOTAL: 4	1460864	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.538	0.0%	301	0.000	11.754	300.000
article cleanup	00:00:24.551	0.0%	1427207	0.000	0.017	0.046
article logging	00:00:39.599	0.0%	1427276	0.000	0.028	0.211
article parse	00:49:26.447	3.4%	109448245	0.008	0.027	0.062
article write	00:13:17.174	0.9%	1423592	0.203	0.560	3.315
artlog/artcncl	00:00:00.002	0.0%	235	0.000	0.009	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:02:12.985	0.2%	117948248	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.775	0.0%	279	0.000	2.778	33.000
hishave/artcncl	00:00:00.186	0.0%	301	0.000	0.618	16.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:45:23.062	7.3%	1461515	0.353	4.326	15.383
history sync	00:00:00.015	0.0%	345	0.000	0.043	1.000
history write	02:23:38.821	10.0%	1424217	0.552	6.052	17.371
hiswrite/artcncl	00:00:00.060	0.0%	22	0.000	2.727	7.667
idle	14:26:28.008	60.2%	72552856	0.316	0.717	6.253
nntp read	00:44:09.875	3.1%	108277077	0.011	0.024	0.037
overview write	00:00:09.265	0.0%	1423592	0.000	0.007	0.031
perl filter	03:10:19.840	13.2%	1424215	3.256	8.018	9.937
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:43.705	0.2%	2878233	0.012	0.057	0.116
TOTAL: 24:00:11.994	23:38:57.908	98.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.104	0.0%	31054	0.000	0.003	0.200
article prepare	00:00:00.010	0.0%	28524	0.000	0.000	0.250
article read	00:00:00.925	0.0%	7103	0.000	0.130	2.000
backlog stats	00:00:00.122	0.0%	202265	0.000	0.001	0.026
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.368	0.0%	128863	0.000	0.011	0.094
data write	00:00:06.183	0.0%	99009	0.000	0.062	20.000
idle	23:59:05.714	100.0%	202265	0.000	426.894	17380.000
status file	00:00:00.337	0.0%	194	0.000	1.737	139.000
TOTAL: 23:59:19.440	23:59:14.763	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.002	0.0%	319	3.141	3.141	3.141
idle	23:20:29.316	99.9%	555447	0.000	151.282	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:18.324	0.0%	1112562	0.000	0.016	0.889
readart	00:00:01.033	0.0%	429	0.000	2.408	281.000
TOTAL: 23:21:37.206	23:20:49.675	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	542	1423882	1420852	176	2854	99%	281:22:44
2	news.nask.pl	2	15747	2731	12394	622	17%	23:22:22
3	news.icm.edu.pl	25	440	104	231	105	23%	16:24:13
4	localhost	10	9	9	0	0	100%	00:00:00
TOTAL: 4		579	1440078	1423696	12801	3581	98%	321:09:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	408.9 GB	37.8 MB	55.7 MB	409.0 GB	99%	301.3 KB
2	news.nask.pl	12.1 MB	1.8 MB	2.1 MB	15.9 MB	75%	4.9 KB
3	news.icm.edu.pl	7.8 MB	166.2 KB	3.3 MB	11.2 MB	69%	54.9 KB
4	localhost	20.3 KB	0.0 KB	0.0 KB	20.3 KB	100%	2.3 KB
TOTAL: 4		409.0 GB	39.8 MB	61.1 MB	409.1 GB	99%	300.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 29 04:15:03 - 04:59:59	64039	4.5%	23.74	18.9 GB	4.6%	7328.95
Nov 29 05:00:00 - 05:59:59	80355	5.6%	22.32	23.5 GB	5.7%	6845.73
Nov 29 06:00:00 - 06:59:59	83859	5.9%	23.29	25.8 GB	6.3%	7508.35
Nov 29 07:00:00 - 07:59:59	84351	5.9%	23.43	26.8 GB	6.6%	7804.49
Nov 29 08:00:00 - 08:59:59	88141	6.2%	24.48	27.5 GB	6.7%	8006.25
Nov 29 09:00:00 - 09:59:59	83223	5.8%	23.12	26.4 GB	6.4%	7675.12
Nov 29 10:00:00 - 10:59:59	80665	5.7%	22.41	24.5 GB	6.0%	7140.83
Nov 29 11:00:00 - 11:59:59	86935	6.1%	24.15	24.2 GB	5.9%	7041.79
Nov 29 12:00:00 - 12:59:59	93539	6.6%	25.98	25.5 GB	6.2%	7437.41
Nov 29 13:00:00 - 13:59:59	75684	5.3%	21.02	19.5 GB	4.8%	5672.54
Nov 29 14:00:00 - 14:59:59	47927	3.4%	13.31	11.1 GB	2.7%	3223.83
Nov 29 15:00:00 - 15:59:59	45752	3.2%	12.71	10.9 GB	2.7%	3169.65
Nov 29 16:00:00 - 16:59:59	71504	5.0%	19.86	19.5 GB	4.8%	5683.25
Nov 29 17:00:00 - 17:59:59	60654	4.3%	16.85	17.1 GB	4.2%	4979.93
Nov 29 18:00:00 - 18:59:59	13411	0.9%	3.73	3.0 GB	0.7%	864.58
Nov 29 19:00:00 - 19:59:59	12258	0.9%	3.40	2.8 GB	0.7%	805.50
Nov 29 20:00:00 - 20:59:59	13396	0.9%	3.72	3.3 GB	0.8%	957.48
Nov 29 21:00:00 - 21:59:59	13432	0.9%	3.73	3.3 GB	0.8%	967.89
Nov 29 22:00:00 - 22:59:59	11456	0.8%	3.18	2.7 GB	0.7%	780.55
Nov 29 23:00:00 - 23:59:59	12582	0.9%	3.50	2.9 GB	0.7%	848.41
Nov 30 00:00:00 - 00:59:59	58410	4.1%	16.23	17.0 GB	4.1%	4939.04
Nov 30 01:00:00 - 01:59:59	73890	5.2%	20.52	22.5 GB	5.5%	6555.55
Nov 30 02:00:00 - 02:59:59	76594	5.4%	21.28	23.7 GB	5.8%	6897.32
Nov 30 03:00:00 - 03:59:59	72301	5.1%	20.08	21.3 GB	5.2%	6208.84
Nov 30 04:00:00 - 04:15:02	18885	1.3%	20.94	5.5 GB	1.3%	6416.64
TOTAL: 23:59:59	1423243	100.0%	16.47	408.9 GB	100.0%	4963.08

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	2904	259	2400	0	245
2	news.nask.pl	653	60	583	1	9
3	news.icm.edu.pl	129	0	9	0	120
TOTAL: 3		3686	319	2992	1	374

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	94
alt.sex.telephones	42
comp.sys.raspberry-pi	40
it.comp.os.win.windows8	28
comp.mobile.android	24
nl.comp.os.linux.techniek	18
it.tlc.cellulari.android	17
comp.mobile.ipad	17
it.comp.os.win.windows7	15
nl.comp.sys.android	11
uk.rec.cycling.moderated	7
hr.alt.cellular.gsm.android	2
it.discussioni.energia	1
hr.ponuda.hardver.komponente	1
hr.ponuda.hardver.konfiguracije	1
hr.alt.cellular.gsm.iphone	1
TOTAL: 16	319

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	176
EMP (md5)	126
Attached HTML file	1
TOTAL: 3	303

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	34065	2019	22803	3649	1	15	5%	23:59:26
2	panorama	31740	1165	29739	176	1	0	3%	24:01:17
3	nask	22460	89	13469	3	0	0	0%	23:58:15
4	poznan	3796	13	2708	15	0	0	0%	24:00:34
5	okapi	0	0	0	0	0	1759	0%	24:00:00
TOTAL: 5		92061	3286	68719	3843	2	1774	3%	119:59:32

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	370.3 MB	764.2 MB	1.1 GB	13.5 KB/s	205.0 KB	23:59:26
2	panorama	5.4 MB	735.9 KB	6.1 MB	0.1 KB/s	4.6 KB	24:01:17
3	nask	930.8 KB	17.4 KB	948.2 KB	0.0 KB/s	10.3 KB	23:58:15
4	poznan	31.9 KB	25.8 KB	57.7 KB	0.0 KB/s	2.1 KB	24:00:34
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		376.6 MB	764.9 MB	1.1 GB	2.7 KB/s	164.0 KB	119:59:32

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	374	616.1 KB	288	0	00:00:08
2	web.man.lodz.pl	289	55	267.5 KB	28	1	00:00:26
3	isvcs01.man.lodz.pl	8	0	0.0 KB	0	8	00:00:01
TOTAL: 3		585	429	883.6 KB	316	9	23:21:36

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	374	616.1 KB	288	0	00:00:08
2	*.man.lodz.pl	681	55	267.5 KB	28	9	00:00:34
3	*.191.14.62.static.jazztel.es	3	0	0.0 KB	0	0	23:20:03
4	*.elsnet.pl	12	0	0.0 KB	0	0	00:00:49
5	*.toya.net.pl	7	0	0.0 KB	0	0	00:00:00
TOTAL: 5		991	429	883.6 KB	316	9	23:21:36

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
180.191.14.62.static.jazztel.es	24.675	37.410	23:20:03
host227.elsnet.pl	0.017	0.105	00:00:49
web.man.lodz.pl	1.084	3.192	00:00:26
pc-skrzep2.cm.p.lodz.pl	1.082	2.956	00:00:08
mon.man.lodz.pl	1.015	2.705	00:00:05
david.man.lodz.pl	0.354	0.867	00:00:01
isvcs01.man.lodz.pl	0.040	0.107	00:00:01
staticline41435.toya.net.pl	0.024	0.079	00:00:00
TOTAL: 8	28.291	47.421	23:21:36

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
host227.elsnet.pl	12
staticline41435.toya.net.pl	7
180.191.14.62.static.jazztel.es	3
TOTAL: 5	406

NNRP client timeouts [Top 20]:

System	Conn	Peer
180.191.14.62.static.jazztel.es	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	374	87.2%
2	pl	55	12.8%
TOTAL: 2		429	100.0%

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

Newsgroup		Count
1	lodman.info	374
2	pl.comp.pecet	32
3	pl.comp.os.ms-windows.winnt	20
4	pl.internet.polip	2
5	pl.rec.mineraly	1
TOTAL: 5		429

Daily Usenet report

Nov 29 04:15:03 -- Nov 30 04:15:02