Daily Usenet report: Jan 4 04:15:04

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jan 4 09:05:32 newsfeed nnrpd[23199]: SERVER perl filter not defined
Jan 4 11:50:04 newsfeed pgpverify[28844]: pgpverify: verification failed
Jan 4 12:22:12 newsfeed nnrpd[29917]: SERVER perl filter not defined
Jan 4 12:23:27 newsfeed nnrpd[30067]: SERVER perl filter not defined
Jan 4 12:24:54 newsfeed nnrpd[30108]: SERVER perl filter not defined
Jan 4 12:25:21 newsfeed nnrpd[30153]: SERVER perl filter not defined
Jan 4 12:26:02 newsfeed nnrpd[30155]: SERVER perl filter not defined
Jan 4 12:45:17 newsfeed nnrpd[30842]: SERVER perl filter not defined
Jan 4 15:32:13 newsfeed nnrpd[4114]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2569575	98.0%	298.8 MB	97.6%
innfeed	26901	1.0%	3.2 MB	1.1%
innd	20892	0.8%	3.6 MB	1.2%
nnrpd	5365	0.2%	579.4 KB	0.2%
controlchan	3	0.0%	0.5 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2622737	100.0%	306.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2558790	96.8%
Negative hits	60415	2.3%
Positive hits	22747	0.9%
Cache misses	187	0.0%
TOTAL: 4	2642139	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:07.132	0.0%	338	0.000	21.101	702.000
article cleanup	00:00:36.136	0.0%	2569280	0.003	0.014	0.029
article logging	00:01:13.181	0.1%	2569783	0.013	0.028	0.354
article parse	01:16:50.920	5.3%	268263089	0.006	0.017	0.086
article write	00:24:17.690	1.7%	2559667	0.301	0.569	3.553
artlog/artcncl	00:00:00.006	0.0%	290	0.000	0.021	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:05:46.137	0.4%	285046083	0.000	0.001	0.005
hisgrep/artcncl	00:00:00.845	0.0%	252	0.000	3.353	157.000
hishave/artcncl	00:00:00.159	0.0%	338	0.000	0.470	17.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:33:52.839	2.4%	2643495	0.087	0.769	18.593
history sync	00:00:00.016	0.0%	296	0.000	0.054	1.000
history write	00:47:26.785	3.3%	2560257	0.092	1.112	31.404
hiswrite/artcncl	00:00:00.105	0.0%	86	0.000	1.221	15.000
idle	12:45:36.353	53.2%	187370426	0.114	0.245	1.096
nntp read	01:38:00.260	6.8%	266226385	0.010	0.022	0.060
overview write	00:00:14.577	0.0%	2559667	0.001	0.006	0.017
perl filter	05:27:42.975	22.8%	2560255	4.760	7.680	12.082
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:16.188	0.4%	5169343	0.025	0.061	0.104
TOTAL: 24:00:16.049	23:07:02.304	96.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.268	0.0%	103170	0.000	0.003	0.048
article prepare	00:00:00.016	0.0%	49684	0.000	0.000	0.083
article read	00:01:18.838	0.1%	12427	0.000	6.344	337.333
backlog stats	00:00:00.203	0.0%	275968	0.000	0.001	0.022
callbacks	00:00:00.000	0.0%	18	0.000	0.000	0.000
data read	00:00:01.834	0.0%	153619	0.000	0.012	0.136
data write	00:00:09.155	0.0%	107116	0.000	0.085	1.278
idle	23:57:59.273	99.9%	275968	46.036	312.642	1684.432
status file	00:00:06.654	0.0%	8820	0.000	0.754	2.600
TOTAL: 23:59:47.235	23:59:36.241	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:33:40.050	99.8%	5928	0.000	1555.339	180117.700
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.300	0.0%	12967	0.000	0.023	0.789
readart	00:00:01.096	0.0%	176	0.000	6.227	26.875
TOTAL: 02:33:57.916	02:33:41.446	99.8%	-	-	-	-

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
admin@openwatcom.news-admin.org	0	0	0	1	0	0
TOTAL	0	0	0	1	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1100	2565048	2553764	2115	9169	99%	311:29:27
2	news.nask.pl	2	17222	5301	11489	432	30%	24:28:24
3	news.icm.edu.pl	42	275	41	208	26	14%	18:12:18
4	localhost	9	8	8	0	0	100%	00:00:00
TOTAL: 4		1153	2582553	2559114	13812	9627	99%	354:10:09

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	797.3 GB	1.1 GB	1.2 GB	799.6 GB	99%	327.2 KB
2	news.nask.pl	20.9 MB	1.4 MB	1.4 MB	23.7 MB	88%	4.2 KB
3	news.icm.edu.pl	640.5 KB	227.1 KB	854.5 KB	1.7 MB	37%	25.7 KB
4	localhost	12.2 KB	0.0 KB	0.0 KB	12.2 KB	100%	1.5 KB
TOTAL: 4		797.4 GB	1.1 GB	1.2 GB	799.7 GB	99%	326.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 4 04:15:04 - 04:59:59	70613	2.8%	26.19	22.5 GB	2.8%	8768.76
Jan 4 05:00:00 - 05:59:59	79985	3.1%	22.22	25.7 GB	3.2%	7485.29
Jan 4 06:00:00 - 06:59:59	88430	3.5%	24.56	28.0 GB	3.5%	8162.88
Jan 4 07:00:00 - 07:59:59	116579	4.6%	32.38	36.7 GB	4.6%	10703.58
Jan 4 08:00:00 - 08:59:59	99074	3.9%	27.52	31.0 GB	3.9%	9028.18
Jan 4 09:00:00 - 09:59:59	112279	4.4%	31.19	34.7 GB	4.4%	10112.58
Jan 4 10:00:00 - 10:59:59	73707	2.9%	20.47	24.7 GB	3.1%	7197.06
Jan 4 11:00:00 - 11:59:59	78464	3.1%	21.80	28.7 GB	3.6%	8354.20
Jan 4 12:00:00 - 12:59:59	109452	4.3%	30.40	35.0 GB	4.4%	10190.31
Jan 4 13:00:00 - 13:59:59	103968	4.1%	28.88	35.8 GB	4.5%	10431.84
Jan 4 14:00:00 - 14:59:59	105633	4.1%	29.34	36.2 GB	4.6%	10553.71
Jan 4 15:00:00 - 15:59:59	116955	4.6%	32.49	38.0 GB	4.8%	11073.75
Jan 4 16:00:00 - 16:59:59	115175	4.5%	31.99	37.0 GB	4.6%	10779.05
Jan 4 17:00:00 - 17:59:59	113336	4.4%	31.48	35.2 GB	4.4%	10244.79
Jan 4 18:00:00 - 18:59:59	120883	4.7%	33.58	35.3 GB	4.4%	10279.88
Jan 4 19:00:00 - 19:59:59	120651	4.7%	33.51	34.7 GB	4.4%	10093.54
Jan 4 20:00:00 - 20:59:59	108264	4.2%	30.07	31.3 GB	3.9%	9114.67
Jan 4 21:00:00 - 21:59:59	132225	5.2%	36.73	35.9 GB	4.5%	10470.39
Jan 4 22:00:00 - 22:59:59	127287	5.0%	35.36	36.3 GB	4.6%	10569.37
Jan 4 23:00:00 - 23:59:59	109323	4.3%	30.37	34.6 GB	4.3%	10078.61
Jan 5 00:00:00 - 00:59:59	97748	3.8%	27.15	30.0 GB	3.8%	8732.21
Jan 5 01:00:00 - 01:59:59	115509	4.5%	32.09	34.4 GB	4.3%	10024.90
Jan 5 02:00:00 - 02:59:59	102098	4.0%	28.36	32.1 GB	4.0%	9361.31
Jan 5 03:00:00 - 03:59:59	111894	4.4%	31.08	33.2 GB	4.2%	9678.07
Jan 5 04:00:00 - 04:15:02	29635	1.2%	32.85	8.7 GB	1.1%	10120.50
TOTAL: 23:59:58	2559167	100.0%	29.62	795.9 GB	100.0%	9659.50

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	9602	231	8617	3	751
2	news.nask.pl	490	6	403	1	80
3	news.icm.edu.pl	26	0	5	0	21
TOTAL: 3		10118	237	9025	4	852

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	136
it.tlc.cellulari.android	27
it.comp.os.win.windows10	23
it.comp.os.win.windows7	13
nl.comp.os.linux.techniek	12
comp.mobile.android	8
de.comp.office-pakete.ms-office.excel	5
de.comp.lang.php	4
hr.alt.cellular.gsm.android	4
hr.ponuda.hardver.komponente	3
it.discussioni.energia	1
de.comp.office-pakete.ms-office.word	1
TOTAL: 12	237

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

Groups	Count
pl.praca.oferowana	2
pl.sci.matematyka	1
bit.listserv.catholic	1
TOTAL: 3	4

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	304
EMP (md5)	19
HTML post	12
EMP (fsl)	11
Scoring filter (8)	1
TOTAL: 5	347

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	55324	1222	38935	576	44	62370	2%	23:59:35
2	icm	60133	938	35682	8924	0	14	1%	24:00:09
3	poznan	8055	193	4956	71	0	0	2%	24:04:26
4	nask	0	0	0	0	0	23139	0%	24:00:01
5	okapi	0	0	0	0	0	2801	0%	24:00:01
TOTAL: 5		123512	2353	79573	9571	44	88324	1%	120:04:12

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	47.5 MB	1.8 GB	1.8 GB	22.0 KB/s	192.8 KB	24:00:09
2	panorama	5.9 MB	4.5 MB	10.4 MB	0.1 KB/s	5.9 KB	23:59:35
3	poznan	774.2 KB	124.2 KB	898.4 KB	0.0 KB/s	3.4 KB	24:04:26
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		54.2 MB	1.8 GB	1.8 GB	4.4 KB/s	160.4 KB	120:04:12

Backlog files shrunk by innfeed:

Server	Size
panorama	2.4 MB
TOTAL: 1	2.4 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	lze200.lze.lodz.pl	9	95	210.6 KB	12	0	02:24:11
2	web.man.lodz.pl	288	80	68.1 KB	37	0	00:00:34
3	awh31.neoplus.adsl.tpnet.pl	1	1	0.8 KB	1	0	00:01:09
4	isvcs01.man.lodz.pl	8	0	0.0 KB	0	8	00:00:00
TOTAL: 4		306	176	279.5 KB	50	8	02:33:57

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.lze.lodz.pl	9	95	210.6 KB	12	0	02:24:11
2	*.man.lodz.pl	680	80	68.1 KB	37	8	00:00:40
3	*.neoplus.adsl.tpnet.pl	1	1	0.8 KB	1	0	00:01:09
4	*.elsnet.pl	2	0	0.0 KB	0	0	00:01:50
5	*.toya.net.pl	99	0	0.0 KB	0	0	00:00:08
6	unresolved	3	0	0.0 KB	0	0	00:05:57
TOTAL: 6		794	176	279.5 KB	50	8	02:33:57

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
lze200.lze.lodz.pl	0.036	0.181	02:24:11
185.48.195.19	0.166	0.174	00:05:55
host227.elsnet.pl	0.005	0.022	00:01:50
awh31.neoplus.adsl.tpnet.pl	0.008	0.008	00:01:09
web.man.lodz.pl	0.926	4.317	00:00:34
staticline41435.toya.net.pl	0.361	1.486	00:00:08
mon.man.lodz.pl	0.821	4.085	00:00:04
76.235.175.221	0.000	0.013	00:00:02
david.man.lodz.pl	0.265	1.237	00:00:01
isvcs01.man.lodz.pl	0.059	0.115	00:00:00
TOTAL: 10	2.647	11.638	02:33:57

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
staticline41435.toya.net.pl	99
david.man.lodz.pl	96
185.48.195.19	2
host227.elsnet.pl	2
76.235.175.221	1
TOTAL: 6	488

NNRP client timeouts [Top 20]:

System	Conn	Peer
lze200.lze.lodz.pl	4	0
TOTAL: 1	4	0

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	175	99.4%
2	lodz	1	0.6%
TOTAL: 2		176	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	114
2	pl.comp.os.ms-windows.winnt	15
3	pl.rec.dom	13
4	pl.internet.polip	11
5	pl.comp.os.linux	8
6	pl.misc.telefonia.gsm	7
7	pl.rec.kuchnia	5
8	pl.regionalne.lodz	2
9	lodz.test	1
TOTAL: 9		176

Daily Usenet report

Jan 4 04:15:04 -- Jan 5 04:15:02