Daily Usenet report: Aug 16 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Aug 16 10:03:44 newsfeed nnrpd[4732]: SERVER perl filter not defined
Aug 16 10:48:00 newsfeed nnrpd[3038]: SERVER perl filter not defined
Aug 16 10:49:06 newsfeed nnrpd[3206]: SERVER perl filter not defined
Aug 16 10:49:41 newsfeed nnrpd[3208]: SERVER perl filter not defined
Aug 16 12:38:47 newsfeed nnrpd[7086]: SERVER perl filter not defined
Aug 16 14:43:21 newsfeed overchan[2612]: input line too long, skipping
Aug 16 15:08:12 newsfeed nnrpd[12144]: SERVER perl filter not defined
Aug 16 15:11:02 newsfeed nnrpd[12351]: SERVER perl filter not defined
Aug 16 22:29:49 newsfeed nnrpd[27427]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2855125	98.7%	332.0 MB	98.4%
innd	27923	1.0%	4.3 MB	1.3%
innfeed	4841	0.2%	674.9 KB	0.2%
nnrpd	4808	0.2%	500.7 KB	0.1%
overchan	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2892699	100.0%	337.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2849072	96.6%
Negative hits	86032	2.9%
Positive hits	14700	0.5%
Cache misses	100	0.0%
TOTAL: 4	2949904	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.908	0.0%	158	0.000	5.747	119.000
article cleanup	00:00:41.677	0.0%	2854665	0.006	0.015	0.029
article logging	00:01:18.692	0.1%	2855166	0.014	0.028	0.587
article parse	01:17:47.508	5.4%	239367271	0.009	0.019	0.073
article write	00:21:49.675	1.5%	2845049	0.270	0.460	1.392
artlog/artcncl	00:00:00.004	0.0%	157	0.000	0.025	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:02:50.371	0.2%	257696939	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.141	0.0%	145	0.000	0.972	16.000
hishave/artcncl	00:00:00.046	0.0%	158	0.000	0.291	8.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:21:16.870	1.5%	2951790	0.036	0.433	7.776
history sync	00:00:00.014	0.0%	295	0.000	0.047	1.000
history write	00:30:14.990	2.1%	2851038	0.108	0.637	9.646
hiswrite/artcncl	00:00:00.031	0.0%	13	0.000	2.385	22.000
idle	13:40:44.671	57.0%	184549904	0.194	0.267	0.601
nntp read	01:10:02.119	4.9%	237092726	0.011	0.018	0.041
overview write	00:00:15.204	0.0%	2845049	0.000	0.005	0.013
perl filter	05:52:14.291	24.5%	2851037	5.523	7.413	10.262
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:41.447	0.3%	5718161	0.034	0.049	0.116
TOTAL: 23:59:13.451	23:23:58.659	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.106	0.0%	35944	0.000	0.003	0.200
article prepare	00:00:00.002	0.0%	21754	0.000	0.000	0.025
article read	00:00:20.810	0.0%	5450	0.000	3.818	280.444
backlog stats	00:00:00.141	0.0%	164676	0.000	0.001	0.038
callbacks	00:00:00.000	0.0%	14	0.000	0.000	0.000
data read	00:00:01.115	0.0%	93956	0.000	0.012	0.091
data write	00:00:03.741	0.0%	70476	0.000	0.053	0.226
idle	23:58:00.329	100.0%	164676	85.830	523.940	3192.350
status file	00:00:00.587	0.0%	874	0.000	0.672	3.000
TOTAL: 23:58:31.011	23:58:26.831	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	10:45:10.567	99.9%	398127	0.000	97.232	325.778
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:13.646	0.0%	796844	0.000	0.017	0.500
readart	00:00:00.077	0.0%	72	0.000	1.069	2.156
TOTAL: 10:45:55.566	10:45:24.290	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	1131	2842273	2831009	7517	3747	99%	292:33:30
2	news.nask.pl	2	22422	13298	3295	5829	59%	23:49:59
3	news.icm.edu.pl	48	207	12	192	3	5%	15:29:51
4	localhost	9	8	8	0	0	100%	00:00:01
TOTAL: 4		1190	2864910	2844327	11004	9579	99%	331:53:21

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	875.3 GB	141.0 MB	178.2 MB	875.6 GB	99%	323.9 KB
2	news.nask.pl	77.4 MB	795.3 KB	66.3 MB	144.5 MB	53%	7.7 KB
3	news.icm.edu.pl	412.8 KB	0.0 KB	33.8 KB	446.6 KB	92%	29.8 KB
4	localhost	15.5 KB	0.0 KB	0.0 KB	15.5 KB	100%	1.9 KB
TOTAL: 4		875.3 GB	141.8 MB	244.5 MB	875.7 GB	99%	321.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 16 04:15:02 - 04:59:59	81012	2.8%	30.03	27.2 GB	3.1%	10556.75
Aug 16 05:00:00 - 05:59:59	105968	3.7%	29.44	34.4 GB	3.9%	10030.16
Aug 16 06:00:00 - 06:59:59	143271	5.0%	39.80	36.9 GB	4.2%	10760.96
Aug 16 07:00:00 - 07:59:59	136309	4.8%	37.86	39.1 GB	4.5%	11389.32
Aug 16 08:00:00 - 08:59:59	91351	3.2%	25.38	28.8 GB	3.3%	8388.27
Aug 16 09:00:00 - 09:59:59	128963	4.5%	35.82	37.4 GB	4.3%	10906.96
Aug 16 10:00:00 - 10:59:59	112358	3.9%	31.21	36.6 GB	4.2%	10651.51
Aug 16 11:00:00 - 11:59:59	111925	3.9%	31.09	38.0 GB	4.3%	11073.78
Aug 16 12:00:00 - 12:59:59	142158	5.0%	39.49	40.1 GB	4.6%	11667.01
Aug 16 13:00:00 - 13:59:59	114048	4.0%	31.68	38.0 GB	4.3%	11066.17
Aug 16 14:00:00 - 14:59:59	109099	3.8%	30.31	35.8 GB	4.1%	10440.47
Aug 16 15:00:00 - 15:59:59	106546	3.7%	29.60	38.3 GB	4.4%	11160.16
Aug 16 16:00:00 - 16:59:59	137534	4.8%	38.20	39.2 GB	4.5%	11408.29
Aug 16 17:00:00 - 17:59:59	176214	6.2%	48.95	40.8 GB	4.7%	11891.93
Aug 16 18:00:00 - 18:59:59	138399	4.9%	38.44	38.1 GB	4.4%	11111.38
Aug 16 19:00:00 - 19:59:59	111362	3.9%	30.93	35.7 GB	4.1%	10392.98
Aug 16 20:00:00 - 20:59:59	122050	4.3%	33.90	38.1 GB	4.4%	11095.18
Aug 16 21:00:00 - 21:59:59	124061	4.4%	34.46	37.5 GB	4.3%	10911.76
Aug 16 22:00:00 - 22:59:59	117648	4.1%	32.68	38.6 GB	4.4%	11230.87
Aug 16 23:00:00 - 23:59:59	111113	3.9%	30.86	38.1 GB	4.3%	11087.07
Aug 17 00:00:00 - 00:59:59	92530	3.3%	25.70	29.8 GB	3.4%	8672.94
Aug 17 01:00:00 - 01:59:59	97466	3.4%	27.07	32.5 GB	3.7%	9475.83
Aug 17 02:00:00 - 02:59:59	111440	3.9%	30.96	34.8 GB	4.0%	10138.39
Aug 17 03:00:00 - 03:59:59	96870	3.4%	26.91	33.1 GB	3.8%	9629.77
Aug 17 04:00:00 - 04:15:02	25160	0.9%	27.89	8.8 GB	1.0%	10204.46
TOTAL: 24:00:00	2844855	100.0%	32.93	875.6 GB	100.0%	10627.07

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	6038	56	290	3	5689
2	newsfeed.pionier.net.pl	4072	167	3334	0	571
3	news.icm.edu.pl	3	0	0	0	3
TOTAL: 3		10113	223	3624	3	6263

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	66
it.comp.os.win.windows10	45
comp.mobile.android	33
it.tlc.cellulari.android	21
de.rec.sf.startrek	14
comp.mobile.ipad	13
it.comp.os.win.windows7	10
de.comp.lang.vbclassic	7
de.comp.lang.php	6
hr.alt.cellular.gsm.android	2
nl.actueel	1
alt.sex.telephones	1
nl.comp.3d-printen	1
uk.rec.cycling.moderated	1
it.comp.dotnet	1
it.discussioni.energia	1
TOTAL: 16	223

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	5071
Binary in non-binary group	365
Scoring filter (8)	164
EMP (phl)	78
Scoring filter (9)	23
Scoring filter (11)	14
HTML post	11
Scoring filter (13)	9
Scoring filter (10)	8
Scoring filter (12)	8
Scoring filter (14)	4
EMP (fsl)	2
Scoring filter (16)	1
Scoring filter (20)	1
Scoring filter (15)	1
Scoring filter (17)	1
TOTAL: 16	5761

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	7879	1476	4464	575	34	29314	18%	23:56:47
2	poznan	20038	204	13038	41	0	0	1%	23:50:00
3	icm	32330	147	23645	2711	0	0	0%	23:50:01
4	nask	6685	23	4513	0	0	0	0%	23:57:33
5	okapi	0	0	0	0	0	2298	0%	24:00:03
TOTAL: 5		66932	1850	45660	3327	34	31612	2%	119:34:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	6.0 MB	2.8 MB	8.8 MB	0.1 KB/s	4.4 KB	23:56:47
2	icm	3.7 MB	568.1 MB	571.8 MB	6.8 KB/s	204.9 KB	23:50:01
3	poznan	982.2 KB	467.6 KB	1.4 MB	0.0 KB/s	5.9 KB	23:50:00
4	nask	85.4 KB	0.0 KB	85.4 KB	0.0 KB/s	3.7 KB	23:57:33
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 5		10.8 MB	571.4 MB	582.2 MB	1.4 KB/s	115.1 KB	119:34:24

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	web.man.lodz.pl	287	40	42.8 KB	19	0	00:00:20
2	isvcs01.man.lodz.pl	8	0	0.0 KB	0	8	00:00:00
TOTAL: 2		295	40	42.8 KB	19	8	10:45:55

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	679	40	42.8 KB	19	8	00:00:25
2	unresolved	2	0	0.0 KB	0	0	10:45:30
TOTAL: 2		681	40	42.8 KB	19	8	10:45:55

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.194.66	18.694	27.594	10:45:27
web.man.lodz.pl	1.097	3.574	00:00:20
mon.man.lodz.pl	0.855	3.242	00:00:03
196.52.18.56	0.006	0.012	00:00:03
david.man.lodz.pl	0.298	1.028	00:00:01
isvcs01.man.lodz.pl	0.062	0.069	00:00:00
TOTAL: 6	21.012	35.519	10:45:55

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
196.52.18.56	1
185.48.194.66	1
TOTAL: 4	386

NNRP client timeouts [Top 20]:

System	Conn	Peer
185.48.194.66	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	30
2	pl.comp.pecet	10
TOTAL: 2		40

Daily Usenet report

Aug 16 04:15:02 -- Aug 17 04:15:02