Daily Usenet report: Jul 2 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jul 2 05:52:18 newsfeed pgpverify[12038]: pgpverify: verification failed
Jul 2 11:58:04 newsfeed nnrpd[25730]: SERVER perl filter not defined
Jul 2 12:06:59 newsfeed overchan[8128]: input line too long, skipping
Jul 2 12:14:03 newsfeed nnrpd[26382]: SERVER perl filter not defined
Jul 2 14:38:54 newsfeed overchan[8128]: input line too long, skipping
Jul 2 17:57:51 newsfeed overchan[8128]: input line too long, skipping
Jul 2 21:55:43 newsfeed nnrpd[15019]: SERVER perl filter not defined
Jul 2 22:07:24 newsfeed nnrpd[15409]: SERVER perl filter not defined
Jul 2 23:19:06 newsfeed overchan[8128]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	427020	89.1%	46.5 MB	88.2%
innfeed	41417	8.6%	4.8 MB	9.1%
innd	5870	1.2%	935.8 KB	1.7%
nnrpd	4766	1.0%	499.4 KB	0.9%
overchan	4	0.0%	0.5 KB	0.0%
controlchan	4	0.0%	0.6 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 7	479082	100.0%	52.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	405917	71.2%
Negative hits	140269	24.6%
Positive hits	23515	4.1%
Cache misses	374	0.1%
TOTAL: 4	570075	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:06.298	0.0%	369	0.000	17.068	81.000
article cleanup	00:00:05.998	0.0%	436926	0.000	0.014	0.053
article logging	00:00:21.466	0.0%	437278	0.000	0.049	0.128
article parse	00:08:18.852	0.6%	19072769	0.000	0.026	0.066
article write	00:03:06.719	0.2%	420737	0.119	0.444	5.824
artlog/artcncl	00:00:00.014	0.0%	366	0.000	0.038	0.167
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:30.777	0.0%	21551660	0.000	0.001	0.418
hisgrep/artcncl	00:00:02.938	0.0%	369	0.000	7.962	31.000
hishave/artcncl	00:00:00.376	0.0%	369	0.000	1.019	1.216
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:10:53.588	0.8%	594359	0.058	1.100	7.205
history sync	00:00:00.034	0.0%	397	0.000	0.086	0.667
history write	00:39:37.357	2.7%	422850	0.344	5.622	44.750
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	21:51:31.759	91.0%	15152360	0.302	5.193	6056.121
nntp read	00:11:35.354	0.8%	18815098	0.006	0.037	0.177
overview write	00:00:02.350	0.0%	420737	0.000	0.006	0.048
perl filter	00:47:04.398	3.3%	422850	0.988	6.679	26.310
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:59.526	0.1%	891848	0.008	0.067	0.143
TOTAL: 24:01:04.335	23:54:17.804	99.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.387	0.0%	178196	0.000	0.002	0.013
article prepare	00:00:00.011	0.0%	40552	0.000	0.000	0.014
article read	00:00:07.865	0.0%	8976	0.000	0.876	27.200
backlog stats	00:00:00.244	0.0%	355632	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	2	0.000	0.000	0.000
data read	00:00:03.623	0.0%	205452	0.005	0.018	0.039
data write	00:00:11.336	0.0%	162007	0.020	0.070	0.153
idle	23:54:13.708	99.9%	355632	35.608	241.974	1313.724
status file	00:00:13.627	0.0%	16105	0.569	0.846	1.143
TOTAL: 23:55:06.511	23:54:50.801	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:15.298	61.4%	3039	0.000	5.034	115.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.252	1.0%	6704	0.000	0.038	0.667
readart	00:00:00.001	0.0%	34	0.000	0.029	0.500
TOTAL: 00:00:24.918	00:00:15.551	62.4%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	193

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
hun-mnt@news.sztaki.hu	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	94	401696	387423	2758	11515	96%	95:25:55
2	news.nask.pl	2	35636	23964	7358	4314	67%	23:50:32
3	news.icm.edu.pl	34	245	32	196	17	13%	13:36:27
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		135	437581	411423	10312	15846	94%	132:52:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	103.5 GB	4.0 GB	4.0 GB	111.4 GB	92%	292.8 KB
2	news.nask.pl	5.0 GB	783.7 MB	796.8 MB	6.6 GB	76%	243.3 KB
3	news.icm.edu.pl	653.8 KB	10.2 KB	388.5 KB	1.0 MB	62%	21.5 KB
4	localhost	5.3 KB	0.0 KB	0.0 KB	5.3 KB	100%	1.3 KB
TOTAL: 4		108.5 GB	4.7 GB	4.8 GB	118.0 GB	91%	289.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 2 04:15:02 - 04:59:59	92772	22.6%	34.39	24.3 GB	22.4%	9430.57
Jul 2 05:00:00 - 05:59:59	121989	29.7%	33.89	33.0 GB	30.5%	9618.69
Jul 2 06:00:00 - 06:59:59	86935	21.2%	24.15	23.3 GB	21.5%	6775.59
Jul 2 07:00:00 - 07:59:59	78843	19.2%	21.90	21.7 GB	20.1%	6324.35
Jul 2 08:00:00 - 08:59:59	20455	5.0%	5.68	5.9 GB	5.5%	1730.52
Jul 2 09:00:00 - 09:59:59	266	0.1%	0.07	780.8 KB	0.0%	0.22
Jul 2 10:00:00 - 10:59:59	255	0.1%	0.07	708.4 KB	0.0%	0.20
Jul 2 11:00:00 - 11:59:59	318	0.1%	0.09	1.4 MB	0.0%	0.40
Jul 2 12:00:00 - 12:59:59	307	0.1%	0.09	1.2 MB	0.0%	0.34
Jul 2 13:00:00 - 13:59:59	311	0.1%	0.09	1.6 MB	0.0%	0.45
Jul 2 14:00:00 - 14:59:59	425	0.1%	0.12	1.2 MB	0.0%	0.34
Jul 2 15:00:00 - 15:59:59	418	0.1%	0.12	1.4 MB	0.0%	0.39
Jul 2 16:00:00 - 16:59:59	441	0.1%	0.12	1.9 MB	0.0%	0.54
Jul 2 17:00:00 - 17:59:59	468	0.1%	0.13	1.7 MB	0.0%	0.48
Jul 2 18:00:00 - 18:59:59	502	0.1%	0.14	1.9 MB	0.0%	0.55
Jul 2 19:00:00 - 19:59:59	1188	0.3%	0.33	4.0 MB	0.0%	1.14
Jul 2 20:00:00 - 20:59:59	758	0.2%	0.21	3.2 MB	0.0%	0.91
Jul 2 21:00:00 - 21:59:59	667	0.2%	0.19	2.6 MB	0.0%	0.74
Jul 2 22:00:00 - 22:59:59	664	0.2%	0.18	2.8 MB	0.0%	0.81
Jul 2 23:00:00 - 23:59:59	603	0.1%	0.17	1.6 MB	0.0%	0.45
Jul 3 00:00:00 - 00:59:59	452	0.1%	0.13	2.1 MB	0.0%	0.60
Jul 3 01:00:00 - 01:59:59	454	0.1%	0.13	2.2 MB	0.0%	0.64
Jul 3 02:00:00 - 02:59:59	475	0.1%	0.13	2.5 MB	0.0%	0.71
Jul 3 03:00:00 - 03:59:59	405	0.1%	0.11	2.2 MB	0.0%	0.62
Jul 3 04:00:00 - 04:15:02	112	0.0%	0.12	702.0 KB	0.0%	0.78
TOTAL: 24:00:00	410483	100.0%	4.75	108.2 GB	100.0%	1313.65

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	11509	12	11474	0	23
2	news.nask.pl	4640	44	2248	8	2340
3	news.icm.edu.pl	22	0	1	0	21
TOTAL: 3		16171	56	13723	8	2384

Unwanted newsgroups [Top 20]:

Newsgroup	Count
comp.mobile.android	29
comp.sys.raspberry-pi	12
it.comp.os.win.windows10	5
it.tlc.cellulari.android	3
uk.railway	3
de.comp.office-pakete.ms-office.outlook	3
de.rec.sf.startrek	1
TOTAL: 7	56

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

Groups	Count
pl.sci.matematyka	3
pl.praca.oferowana	2
christnet.christianlife	1
christnet.prayer	1
bit.listserv.catholic	1
TOTAL: 5	8

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1915
Binary in non-binary group	66
Scoring filter (8)	33
Scoring filter (9)	11
Too many newsgroups	2
Scoring filter (10)	2
Excessively crossposted test article	1
Scoring filter (16)	1
TOTAL: 8	2031

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.nask.pl	331
	newsfeed.pionier.net.pl	21
	news.icm.edu.pl	1
	TOTAL: 3	353
TOTAL: 1		353

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	137911	4830	105796	593	8	67108	3%	23:59:58
2	nask	29361	1634	23199	0	0	0	5%	08:09:37
3	icm	59094	35	47893	1259	0	44	0%	23:59:58
4	poznan	1064	7	647	2	0	9641	0%	23:59:58
5	okapi	0	0	0	0	0	1026	0%	23:57:51
TOTAL: 5		227430	6506	177535	1854	8	77819	2%	104:07:22

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	615.5 MB	0.0 KB	615.5 MB	21.5 KB/s	385.7 KB	08:09:37
2	panorama	56.9 MB	7.4 MB	64.4 MB	0.8 KB/s	12.2 KB	23:59:58
3	icm	200.6 KB	471.9 MB	472.1 MB	5.6 KB/s	373.6 KB	23:59:58
4	poznan	18.6 KB	3.3 KB	21.8 KB	0.0 KB/s	2.4 KB	23:59:58
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:51
TOTAL: 5		672.7 MB	479.4 MB	1.1 GB	3.1 KB/s	141.1 KB	104:07:22

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	34	36.9 KB	16	0	00:00:19
2	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 2		292	34	36.9 KB	16	4	00:00:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	676	34	36.9 KB	16	4	0	00:00:24
TOTAL: 1		676	34	36.9 KB	16	4	0	00:00:24

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.460	4.244	00:00:19
mon.man.lodz.pl	1.272	3.596	00:00:03
david.man.lodz.pl	0.392	1.208	00:00:01
isvcs01.man.lodz.pl	0.028	0.052	00:00:00
TOTAL: 4	3.152	9.100	00:00:24

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
TOTAL: 2	384

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	26
2	pl.comp.os.ms-windows.winnt	8
TOTAL: 2		34

Daily Usenet report

Jul 2 04:15:02 -- Jul 3 04:15:02