Daily Usenet report: Nov 7 04:15:03

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Nov 7 15:39:03 newsfeed nnrpd[6303]: SERVER perl filter not defined
Nov 7 15:39:56 newsfeed nnrpd[6447]: SERVER perl filter not defined
Nov 7 15:46:39 newsfeed nnrpd[6600]: SERVER perl filter not defined
Nov 7 15:54:12 newsfeed nnrpd[6890]: SERVER perl filter not defined
Nov 7 19:35:03 newsfeed nnrpd[14577]: SERVER perl filter not defined
Nov 7 20:47:21 newsfeed nnrpd[17014]: SERVER perl filter not defined
Nov 7 21:06:58 newsfeed nnrpd[17718]: SERVER perl filter not defined
Nov 7 21:35:14 newsfeed nnrpd[18737]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2397841	97.2%	274.3 MB	96.8%
innfeed	45307	1.8%	5.4 MB	1.9%
innd	18756	0.8%	3.3 MB	1.2%
nnrpd	4845	0.2%	518.1 KB	0.2%
TOTAL: 4	2466749	100.0%	283.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2391863	98.5%
Negative hits	20803	0.9%
Positive hits	14904	0.6%
Cache misses	98	0.0%
TOTAL: 4	2427668	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.393	0.0%	260	0.000	9.204	304.000
article cleanup	00:00:37.557	0.0%	2397618	0.006	0.016	0.029
article logging	00:01:05.260	0.1%	2398109	0.014	0.027	0.442
article parse	01:15:25.456	5.2%	289695243	0.005	0.016	0.079
article write	00:22:38.633	1.6%	2394004	0.293	0.568	2.208
artlog/artcncl	00:00:00.006	0.0%	206	0.000	0.029	1.000
data move	00:04:50.260	0.3%	305845661	0.000	0.001	0.006
hisgrep/artcncl	00:00:00.352	0.0%	205	0.000	1.717	15.000
hishave/artcncl	00:00:00.065	0.0%	260	0.000	0.250	2.722
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:28:11.657	2.0%	2430000	0.073	0.696	9.711
history sync	00:00:00.012	0.0%	292	0.000	0.041	1.000
history write	00:52:32.852	3.6%	2394302	0.184	1.317	22.013
hiswrite/artcncl	00:00:00.046	0.0%	55	0.000	0.836	12.000
idle	13:38:48.985	56.9%	208502265	0.104	0.236	2.252
nntp read	01:24:53.665	5.9%	287863228	0.008	0.018	0.038
overview write	00:00:13.242	0.0%	2394004	0.001	0.006	0.015
perl filter	05:00:23.344	20.9%	2394302	4.449	7.528	10.041
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:12.045	0.3%	4828199	0.027	0.052	0.109
TOTAL: 24:00:12.554	23:13:55.830	96.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.236	0.0%	94373	0.000	0.003	0.077
article prepare	00:00:00.012	0.0%	48978	0.000	0.000	0.050
article read	00:01:05.635	0.1%	12263	0.000	5.352	634.000
backlog stats	00:00:00.178	0.0%	243686	0.000	0.001	0.020
callbacks	00:00:00.001	0.0%	29	0.000	0.034	0.100
data read	00:00:01.476	0.0%	130070	0.000	0.011	0.081
data write	00:00:10.146	0.0%	94513	0.000	0.107	3.361
idle	23:58:13.468	99.9%	243686	41.966	354.117	1963.912
status file	00:00:12.071	0.0%	15597	0.167	0.774	18.500
TOTAL: 23:59:54.138	23:59:43.223	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	06:54:53.988	99.9%	172924	0.000	143.959	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:06.127	0.0%	346502	0.000	0.018	0.667
readart	00:00:00.006	0.0%	56	0.000	0.107	0.500
TOTAL: 06:55:21.165	06:55:00.121	99.9%	-	-	-	-

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	821	2393302	2389972	96	3234	99%	255:38:57
2	news.nask.pl	2	15731	3712	11705	314	23%	25:01:15
3	news.icm.edu.pl	37	321	77	168	76	23%	17:39:39
4	localhost	9	8	8	0	0	100%	00:00:00
TOTAL: 4		869	2409362	2393769	11969	3624	99%	298:19:51

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	745.5 GB	16.7 MB	19.4 MB	745.5 GB	99%	326.7 KB
2	news.nask.pl	15.1 MB	1.0 MB	1.1 MB	17.3 MB	87%	4.4 KB
3	news.icm.edu.pl	4.6 MB	33.4 KB	4.6 MB	9.3 MB	49%	61.9 KB
4	localhost	11.1 KB	0.0 KB	0.0 KB	11.1 KB	100%	1.4 KB
TOTAL: 4		745.5 GB	17.8 MB	25.1 MB	745.6 GB	99%	326.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 7 04:15:03 - 04:59:59	70562	2.9%	26.16	23.1 GB	3.1%	8973.87
Nov 7 05:00:00 - 05:59:59	83293	3.5%	23.14	28.9 GB	3.9%	8414.19
Nov 7 06:00:00 - 06:59:59	95490	4.0%	26.52	32.1 GB	4.3%	9344.12
Nov 7 07:00:00 - 07:59:59	105270	4.4%	29.24	33.3 GB	4.5%	9705.92
Nov 7 08:00:00 - 08:59:59	98112	4.1%	27.25	32.7 GB	4.4%	9511.05
Nov 7 09:00:00 - 09:59:59	78431	3.3%	21.79	26.6 GB	3.6%	7749.43
Nov 7 10:00:00 - 10:59:59	78517	3.3%	21.81	26.0 GB	3.5%	7567.65
Nov 7 11:00:00 - 11:59:59	104843	4.4%	29.12	31.8 GB	4.3%	9261.33
Nov 7 12:00:00 - 12:59:59	128611	5.4%	35.73	33.7 GB	4.5%	9803.17
Nov 7 13:00:00 - 13:59:59	98741	4.1%	27.43	30.3 GB	4.1%	8828.86
Nov 7 14:00:00 - 14:59:59	122146	5.1%	33.93	32.6 GB	4.4%	9494.78
Nov 7 15:00:00 - 15:59:59	90128	3.8%	25.04	27.3 GB	3.7%	7939.90
Nov 7 16:00:00 - 16:59:59	75004	3.1%	20.83	25.1 GB	3.4%	7314.42
Nov 7 17:00:00 - 17:59:59	105410	4.4%	29.28	32.6 GB	4.4%	9494.47
Nov 7 18:00:00 - 18:59:59	88776	3.7%	24.66	29.6 GB	4.0%	8611.50
Nov 7 19:00:00 - 19:59:59	100061	4.2%	27.79	31.3 GB	4.2%	9103.19
Nov 7 20:00:00 - 20:59:59	105973	4.4%	29.44	30.9 GB	4.1%	8997.58
Nov 7 21:00:00 - 21:59:59	98059	4.1%	27.24	30.7 GB	4.1%	8932.56
Nov 7 22:00:00 - 22:59:59	106689	4.5%	29.64	34.1 GB	4.6%	9926.39
Nov 7 23:00:00 - 23:59:59	101848	4.3%	28.29	33.2 GB	4.4%	9657.07
Nov 8 00:00:00 - 00:59:59	99387	4.2%	27.61	29.6 GB	4.0%	8618.38
Nov 8 01:00:00 - 01:59:59	110412	4.6%	30.67	34.5 GB	4.6%	10050.88
Nov 8 02:00:00 - 02:59:59	122394	5.1%	34.00	37.1 GB	5.0%	10809.46
Nov 8 03:00:00 - 03:59:59	102600	4.3%	28.50	31.4 GB	4.2%	9150.55
Nov 8 04:00:00 - 04:15:02	22774	1.0%	25.25	7.8 GB	1.0%	9082.97
TOTAL: 23:59:59	2393531	100.0%	27.70	746.0 GB	100.0%	9053.67

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3669	114	3027	1	527
2	news.nask.pl	362	10	285	6	61
3	news.icm.edu.pl	73	0	3	0	70
TOTAL: 3		4104	124	3315	7	658

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	32
it.tlc.cellulari.android	28
it.comp.os.win.windows10	14
de.rec.sf.startrek	14
comp.mobile.android	10
comp.mobile.ipad	6
it.comp.os.win.windows8	5
de.comp.os.os2	4
de.comm.software.mailreader	4
it.comp.os.win.windows7	2
uk.rec.cycling.moderated	2
hr.ponuda.hardver.komponente	1
alt.sex.telephones	1
hr.alt.cellular.gsm.iphone	1
TOTAL: 14	124

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

Groups	Count
christnet.ladies	4
pl.praca.oferowana	2
bit.listserv.catholic	1
TOTAL: 3	7

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	88
EMP (md5)	69
Too many newsgroups	6
Attached HTML file	2
HTML post	1
EMP (fsl)	1
TOTAL: 6	167

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	61271	2803	31383	1127	75	59045	4%	24:02:46
2	icm	44244	247	23403	6959	0	17	0%	24:00:00
3	poznan	5397	58	3470	35	0	0	1%	23:57:24
4	nask	0	0	0	0	0	11965	0%	24:00:01
5	okapi	0	0	0	0	0	1607	0%	24:00:01
TOTAL: 5		110912	3108	58256	8121	75	72634	2%	120:00:12

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	13.3 MB	1.7 GB	1.7 GB	20.4 KB/s	244.7 KB	24:00:00
2	panorama	12.8 MB	8.4 MB	21.2 MB	0.3 KB/s	5.5 KB	24:02:46
3	poznan	179.6 KB	82.5 KB	262.1 KB	0.0 KB/s	2.8 KB	23:57:24
4	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		26.3 MB	1.7 GB	1.7 GB	4.1 KB/s	159.0 KB	120:00:12

Backlog files shrunk by innfeed:

Server	Size
panorama	1.4 MB
TOTAL: 1	1.4 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	56	136.2 KB	24	0	00:00:28
2	isvcs01.man.lodz.pl	8	0	0.0 KB	0	8	00:00:00
TOTAL: 2		296	56	136.2 KB	24	8	06:55:20

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	680	56	136.2 KB	24	8	00:00:34
2	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:05
3	*.toya.net.pl	1	0	0.0 KB	0	0	00:00:00
4	unresolved	3	0	0.0 KB	0	0	06:54:40
TOTAL: 4		686	56	136.2 KB	24	8	06:55:20

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.26	5.052	6.203	04:17:58
185.48.195.60	3.868	4.545	02:36:42
web.man.lodz.pl	0.893	3.176	00:00:28
host227.elsnet.pl	0.013	0.013	00:00:05
mon.man.lodz.pl	0.871	2.882	00:00:04
david.man.lodz.pl	0.288	0.918	00:00:00
isvcs01.man.lodz.pl	0.049	0.101	00:00:00
staticline41435.toya.net.pl	0.004	0.004	00:00:00
TOTAL: 8	11.038	17.842	06:55:20

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.48.193.26	2
host227.elsnet.pl	2
staticline41435.toya.net.pl	1
185.48.195.60	1
TOTAL: 6	390

NNRP client timeouts [Top 20]:

System	Conn	Peer
185.48.193.26	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	56	100.0%
TOTAL: 1		56	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	48
2	pl.comp.os.ms-windows.winnt	6
3	pl.internet.polip	2
TOTAL: 3		56

Daily Usenet report

Nov 7 04:15:03 -- Nov 8 04:15:02