Daily Usenet report: Jun 30 04:15:02

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Jun 30 05:07:07 newsfeed overchan[30341]: input line too long, skipping
Jun 30 05:07:45 newsfeed overchan[30341]: input line too long, skipping
Jun 30 05:08:23 newsfeed overchan[30341]: input line too long, skipping
Jun 30 05:22:57 newsfeed overchan[30341]: input line too long, skipping
Jun 30 05:23:32 newsfeed overchan[30341]: input line too long, skipping
Jun 30 05:23:50 newsfeed overchan[30341]: input line too long, skipping
Jun 30 06:02:48 newsfeed overchan[30341]: input line too long, skipping
Jun 30 06:16:32 newsfeed overchan[30341]: input line too long, skipping
Jun 30 06:31:13 newsfeed overchan[30341]: input line too long, skipping
Jun 30 06:33:37 newsfeed overchan[30341]: input line too long, skipping
Jun 30 09:49:51 newsfeed nnrpd[10972]: SERVER perl filter not defined
Jun 30 10:18:08 newsfeed nnrpd[12096]: SERVER perl filter not defined
Jun 30 10:26:30 newsfeed nnrpd[12454]: SERVER perl filter not defined
Jun 30 13:08:43 newsfeed nnrpd[18457]: SERVER perl filter not defined
Jun 30 13:13:36 newsfeed nnrpd[19305]: SERVER perl filter not defined
Jun 30 16:14:53 newsfeed nnrpd[26176]: SERVER perl filter not defined
Jun 30 16:22:06 newsfeed nnrpd[26381]: SERVER perl filter not defined
Jun 30 16:22:57 newsfeed nnrpd[26531]: SERVER perl filter not defined
Jun 30 23:10:31 newsfeed nnrpd[9354]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2437640	97.0%	284.9 MB	96.7%
innfeed	48805	1.9%	5.8 MB	2.0%
innd	21870	0.9%	3.5 MB	1.2%
nnrpd	4796	0.2%	504.8 KB	0.2%
overchan	10	0.0%	2.0 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2513122	100.0%	294.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2424253	96.0%
Negative hits	88248	3.5%
Positive hits	11991	0.5%
Cache misses	90	0.0%
TOTAL: 4	2524582	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.684	0.0%	181	0.000	9.304	52.000
article cleanup	00:00:33.224	0.0%	2431467	0.011	0.014	0.019
article logging	00:01:26.246	0.1%	2432048	0.027	0.035	0.075
article parse	00:56:28.206	3.9%	198462446	0.009	0.017	0.029
article write	00:20:50.997	1.4%	2423073	0.366	0.516	0.938
artlog/artcncl	00:00:00.004	0.0%	181	0.000	0.022	0.200
data move	00:02:49.942	0.2%	213723054	0.001	0.001	0.001
hisgrep/artcncl	00:00:00.527	0.0%	164	0.000	3.213	21.611
hishave/artcncl	00:00:00.033	0.0%	181	0.000	0.182	1.444
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:15:12.790	1.1%	2528850	0.077	0.361	1.809
history sync	00:00:00.013	0.0%	291	0.000	0.045	1.000
history write	02:06:23.703	8.8%	2428366	0.257	3.123	11.788
hiswrite/artcncl	00:00:00.522	0.0%	17	0.000	30.706	46.200
idle	14:18:07.385	59.6%	130431922	0.277	0.395	0.659
nntp read	01:05:12.611	4.5%	196433644	0.016	0.020	0.030
overview write	00:00:13.096	0.0%	2423073	0.004	0.005	0.008
perl filter	04:21:20.879	18.1%	2428366	5.228	6.457	8.519
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:45.534	0.3%	4868562	0.038	0.046	0.070
TOTAL: 24:00:03.054	23:32:27.396	98.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.183	0.0%	65117	0.000	0.003	0.010
article prepare	00:00:00.002	0.0%	5542	0.000	0.000	0.025
article read	00:00:26.427	0.0%	1377	0.000	19.192	862.500
backlog stats	00:00:00.140	0.0%	172947	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	2	0.000	0.000	0.000
data read	00:00:01.927	0.0%	93788	0.004	0.021	0.049
data write	00:00:03.426	0.0%	72637	0.017	0.047	0.166
idle	23:53:31.529	99.9%	172947	325.182	497.329	956.920
status file	00:00:13.050	0.0%	16553	0.459	0.788	2.967
TOTAL: 23:54:31.966	23:54:16.684	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:17.918	58.2%	3067	0.000	5.842	24.222
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.173	0.6%	6706	0.000	0.026	2.333
readart	00:00:00.002	0.0%	22	0.000	0.091	0.500
TOTAL: 00:00:30.782	00:00:18.093	58.8%	-	-	-	-

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	994	2427061	2417521	6455	3085	99%	445:19:26
2	news.nask.pl	1	17226	9766	2171	5289	56%	24:06:14
3	news.icm.edu.pl	42	292	34	246	12	11%	17:42:39
4	localhost	10	9	9	0	0	100%	00:00:00
TOTAL: 4		1047	2444588	2427330	8872	8386	99%	487:08:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	759.2 GB	22.8 MB	23.9 MB	759.2 GB	99%	328.9 KB
2	news.nask.pl	44.4 MB	729.1 KB	23.8 MB	69.0 MB	64%	4.7 KB
3	news.icm.edu.pl	1.2 MB	37.5 KB	421.1 KB	1.6 MB	72%	36.4 KB
4	localhost	14.4 KB	0.0 KB	0.0 KB	14.4 KB	100%	1.6 KB
TOTAL: 4		759.2 GB	23.5 MB	48.1 MB	759.3 GB	99%	326.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 30 04:15:02 - 04:59:59	38983	1.6%	14.45	11.5 GB	1.5%	4468.12
Jun 30 05:00:00 - 05:59:59	57312	2.4%	15.92	19.2 GB	2.5%	5580.88
Jun 30 06:00:00 - 06:59:59	92105	3.8%	25.58	27.0 GB	3.6%	7874.77
Jun 30 07:00:00 - 07:59:59	109746	4.5%	30.48	34.0 GB	4.5%	9908.00
Jun 30 08:00:00 - 08:59:59	92581	3.8%	25.72	26.0 GB	3.4%	7575.98
Jun 30 09:00:00 - 09:59:59	93125	3.8%	25.87	25.9 GB	3.4%	7548.29
Jun 30 10:00:00 - 10:59:59	117078	4.8%	32.52	32.9 GB	4.3%	9576.40
Jun 30 11:00:00 - 11:59:59	121050	5.0%	33.62	33.9 GB	4.5%	9866.41
Jun 30 12:00:00 - 12:59:59	111530	4.6%	30.98	34.3 GB	4.5%	9976.83
Jun 30 13:00:00 - 13:59:59	119529	4.9%	33.20	36.5 GB	4.8%	10622.55
Jun 30 14:00:00 - 14:59:59	107793	4.4%	29.94	35.6 GB	4.7%	10381.82
Jun 30 15:00:00 - 15:59:59	104906	4.3%	29.14	35.5 GB	4.7%	10326.78
Jun 30 16:00:00 - 16:59:59	98939	4.1%	27.48	35.4 GB	4.7%	10308.94
Jun 30 17:00:00 - 17:59:59	109636	4.5%	30.45	35.4 GB	4.7%	10310.28
Jun 30 18:00:00 - 18:59:59	86108	3.5%	23.92	27.6 GB	3.6%	8039.81
Jun 30 19:00:00 - 19:59:59	105947	4.4%	29.43	34.2 GB	4.5%	9962.14
Jun 30 20:00:00 - 20:59:59	100913	4.2%	28.03	31.1 GB	4.1%	9062.31
Jun 30 21:00:00 - 21:59:59	81302	3.3%	22.58	24.1 GB	3.2%	7034.06
Jun 30 22:00:00 - 22:59:59	79833	3.3%	22.18	24.0 GB	3.2%	6977.49
Jun 30 23:00:00 - 23:59:59	103242	4.3%	28.68	34.7 GB	4.6%	10102.14
Jul 1 00:00:00 - 00:59:59	92367	3.8%	25.66	30.1 GB	4.0%	8779.97
Jul 1 01:00:00 - 01:59:59	126420	5.2%	35.12	40.5 GB	5.3%	11789.32
Jul 1 02:00:00 - 02:59:59	129224	5.3%	35.90	41.7 GB	5.5%	12138.18
Jul 1 03:00:00 - 03:59:59	117627	4.8%	32.67	36.9 GB	4.9%	10753.94
Jul 1 04:00:00 - 04:15:03	31209	1.3%	34.56	10.7 GB	1.4%	12418.25
TOTAL: 24:00:01	2428505	100.0%	28.11	758.6 GB	100.0%	9206.59

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	5455	55	271	5	5124
2	newsfeed.pionier.net.pl	3487	195	2813	1	478
3	news.icm.edu.pl	12	0	2	0	10
TOTAL: 3		8954	250	3086	6	5612

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	116
it.comp.os.win.windows10	45
comp.mobile.android	43
it.tlc.cellulari.android	13
comp.sys.raspberry-pi	8
comp.mobile.ipad	6
de.comp.lang.php	6
de.comp.lang.vbclassic	4
de.rec.sf.startrek	3
de.comm.software.mailreader	2
it.comp.os.win.windows7	2
nl.comp.sys.android	1
alt.os.android	1
TOTAL: 13	250

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	4797
Binary in non-binary group	104
EMP (phl)	45
Scoring filter (8)	33
HTML post	16
Scoring filter (10)	10
Scoring filter (9)	10
Poison newsgroup	5
Scoring filter (11)	5
Too many newsgroups	2
Scoring filter (12)	1
TOTAL: 11	5028

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	404
	news.nask.pl	180
	TOTAL: 2	584
TOTAL: 1		584

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	45802	274	17836	129	3	47100	0%	23:59:57
2	poznan	14692	197	9436	27	0	0	1%	23:53:48
3	icm	26119	70	20047	234	0	1	0%	23:51:31
4	nask	5685	2	4292	161	0	0	0%	23:59:06
5	okapi	0	0	0	0	0	2237	0%	23:50:00
TOTAL: 5		92298	543	51611	551	3	49338	0%	119:34:22

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	787.7 KB	508.3 KB	1.3 MB	0.0 KB/s	3.2 KB	23:59:57
2	poznan	584.4 KB	88.5 KB	673.0 KB	0.0 KB/s	3.0 KB	23:53:48
3	icm	389.0 KB	67.8 MB	68.2 MB	0.8 KB/s	229.7 KB	23:51:31
4	nask	3.8 KB	96.4 MB	96.4 MB	1.1 KB/s	605.6 KB	23:59:06
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:00
TOTAL: 5		1.7 MB	164.8 MB	166.5 MB	0.4 KB/s	155.9 KB	119:34:22

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	22	24.3 KB	10	0	00:00:23
2	isvcs01.man.lodz.pl	9	0	0.0 KB	0	9	00:00:01
TOTAL: 2		297	22	24.3 KB	10	9	00:00:30

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	681	22	24.3 KB	10	9	0	00:00:30
TOTAL: 1		681	22	24.3 KB	10	9	0	00:00:30

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.180	3.144	00:00:23
mon.man.lodz.pl	1.000	2.664	00:00:03
isvcs01.man.lodz.pl	0.056	0.120	00:00:01
david.man.lodz.pl	0.320	0.868	00:00:01
TOTAL: 4	2.556	6.796	00:00:30

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	22	100.0%
TOTAL: 1		22	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	18
2	pl.comp.os.ms-windows.winnt	4
TOTAL: 2		22

Daily Usenet report

Jun 30 04:15:02 -- Jul 1 04:15:03