Daily Usenet report: Jun 17 04:15:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jun 17 05:01:49 newsfeed overchan[27654]: input line too long, skipping
Jun 17 05:11:00 newsfeed overchan[27654]: input line too long, skipping
Jun 17 05:31:45 newsfeed overchan[27654]: input line too long, skipping
Jun 17 13:10:04 newsfeed pgpverify[15233]: pgpverify: verification failed
Jun 18 03:30:08 newsfeed overchan[27654]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1930831	96.5%	225.4 MB	96.3%
innfeed	44981	2.2%	5.3 MB	2.2%
innd	19613	1.0%	3.0 MB	1.3%
nnrpd	4711	0.2%	494.4 KB	0.2%
overchan	5	0.0%	0.8 KB	0.0%
controlchan	4	0.0%	0.4 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 7	2000146	100.0%	234.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1908919	96.0%
Negative hits	68793	3.5%
Positive hits	10164	0.5%
Cache misses	90	0.0%
TOTAL: 4	1987966	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.107	0.0%	175	0.000	17.754	197.000
article cleanup	00:00:26.400	0.0%	1928505	0.011	0.014	0.018
article logging	00:01:12.523	0.1%	1930828	0.028	0.038	0.119
article parse	00:42:50.945	3.0%	136368623	0.012	0.019	0.043
article write	00:14:33.927	1.0%	1919414	0.362	0.455	0.753
artlog/artcncl	00:00:00.002	0.0%	173	0.000	0.012	0.056
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:01.354	0.1%	148045203	0.001	0.001	0.002
hisgrep/artcncl	00:00:01.141	0.0%	156	0.000	7.314	41.250
hishave/artcncl	00:00:00.443	0.0%	175	0.000	2.531	35.750
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:03:39.580	4.4%	2007622	0.085	1.903	9.538
history sync	00:00:00.019	0.0%	291	0.000	0.065	0.500
history write	02:35:58.964	10.8%	1925113	0.520	4.862	14.778
hiswrite/artcncl	00:00:00.917	0.0%	19	0.000	48.263	96.750
idle	14:28:00.108	60.3%	95502639	0.286	0.545	0.962
nntp read	00:49:14.150	3.4%	134757489	0.017	0.022	0.031
overview write	00:00:10.567	0.0%	1919414	0.004	0.006	0.007
perl filter	03:28:37.586	14.5%	1925113	5.646	6.502	8.185
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:21.934	0.2%	3856258	0.040	0.052	0.075
TOTAL: 24:00:02.827	23:30:13.667	97.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.164	0.0%	55561	0.000	0.003	0.016
article prepare	00:00:00.003	0.0%	7554	0.000	0.000	0.031
article read	00:00:23.968	0.0%	1896	0.000	12.641	673.800
backlog stats	00:00:00.103	0.0%	140241	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	8	0.000	0.000	0.000
data read	00:00:01.294	0.0%	76005	0.002	0.017	0.048
data write	00:00:03.144	0.0%	60777	0.005	0.052	0.166
idle	23:54:41.469	99.9%	140241	343.300	613.811	1130.544
status file	00:00:12.402	0.0%	16881	0.510	0.735	1.452
TOTAL: 23:55:35.950	23:55:22.547	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:49.673	80.9%	2984	0.000	16.646	10214.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.183	0.3%	6580	0.000	0.028	1.333
readart	00:00:00.000	0.0%	14	0.000	0.000	0.000
TOTAL: 00:01:01.421	00:00:49.856	81.2%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
newsmaster@carnet.hr	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	930	1918494	1911865	3515	3114	99%	385:18:07
2	news.nask.pl	1	15337	6507	2921	5909	42%	23:43:32
3	news.icm.edu.pl	44	413	31	304	78	7%	17:55:02
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		976	1934244	1918403	6740	9101	99%	426:56:41

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	567.3 GB	26.7 MB	27.8 MB	567.4 GB	99%	310.7 KB
2	news.nask.pl	38.0 MB	1.1 MB	37.0 MB	76.1 MB	49%	6.3 KB
3	news.icm.edu.pl	1.3 MB	34.9 KB	2.7 MB	4.0 MB	32%	38.0 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		567.4 GB	27.9 MB	67.5 MB	567.5 GB	99%	308.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 17 04:15:02 - 04:59:59	87357	4.6%	32.38	24.8 GB	4.4%	9648.50
Jun 17 05:00:00 - 05:59:59	61515	3.2%	17.09	17.9 GB	3.1%	5202.71
Jun 17 06:00:00 - 06:59:59	49757	2.6%	13.82	14.1 GB	2.5%	4112.45
Jun 17 07:00:00 - 07:59:59	47340	2.5%	13.15	12.6 GB	2.2%	3676.60
Jun 17 08:00:00 - 08:59:59	57975	3.0%	16.10	17.4 GB	3.1%	5056.37
Jun 17 09:00:00 - 09:59:59	58057	3.0%	16.13	17.0 GB	3.0%	4959.78
Jun 17 10:00:00 - 10:59:59	55485	2.9%	15.41	16.4 GB	2.9%	4773.71
Jun 17 11:00:00 - 11:59:59	54477	2.8%	15.13	16.0 GB	2.8%	4672.21
Jun 17 12:00:00 - 12:59:59	59931	3.1%	16.65	18.6 GB	3.3%	5413.35
Jun 17 13:00:00 - 13:59:59	78487	4.1%	21.80	23.4 GB	4.1%	6829.90
Jun 17 14:00:00 - 14:59:59	145784	7.6%	40.50	41.5 GB	7.3%	12100.70
Jun 17 15:00:00 - 15:59:59	105823	5.5%	29.40	32.0 GB	5.6%	9315.10
Jun 17 16:00:00 - 16:59:59	122973	6.4%	34.16	36.1 GB	6.4%	10528.84
Jun 17 17:00:00 - 17:59:59	77594	4.0%	21.55	24.5 GB	4.3%	7142.46
Jun 17 18:00:00 - 18:59:59	50022	2.6%	13.89	15.6 GB	2.8%	4557.26
Jun 17 19:00:00 - 19:59:59	49808	2.6%	13.84	14.5 GB	2.6%	4237.61
Jun 17 20:00:00 - 20:59:59	42632	2.2%	11.84	12.3 GB	2.2%	3568.38
Jun 17 21:00:00 - 21:59:59	47374	2.5%	13.16	15.0 GB	2.6%	4369.10
Jun 17 22:00:00 - 22:59:59	59116	3.1%	16.42	18.6 GB	3.3%	5407.56
Jun 17 23:00:00 - 23:59:59	103257	5.4%	28.68	32.0 GB	5.6%	9308.59
Jun 18 00:00:00 - 00:59:59	111065	5.8%	30.85	32.1 GB	5.7%	9341.37
Jun 18 01:00:00 - 01:59:59	130932	6.8%	36.37	37.7 GB	6.6%	10985.80
Jun 18 02:00:00 - 02:59:59	108143	5.6%	30.04	31.7 GB	5.6%	9225.66
Jun 18 03:00:00 - 03:59:59	122068	6.4%	33.91	35.6 GB	6.3%	10380.06
Jun 18 04:00:00 - 04:15:02	32277	1.7%	35.78	9.8 GB	1.7%	11342.03
TOTAL: 24:00:00	1919249	100.0%	22.21	567.3 GB	100.0%	6884.93

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	5995	35	465	3	5492
2	newsfeed.pionier.net.pl	5338	81	2926	2	2329
3	news.icm.edu.pl	76	0	1	0	75
TOTAL: 3		11409	116	3392	5	7896

Unwanted newsgroups [Top 20]:

Newsgroup	Count
comp.mobile.android	43
uk.railway	37
it.comp.os.win.windows10	27
it.comp.os.linux.ubuntu	3
comp.mobile.ipad	3
uk.rec.cycling.moderated	1
alt.sex.telephones	1
comp.sys.raspberry-pi	1
TOTAL: 8	116

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	5217
Binary in non-binary group	220
EMP (phl)	67
Scoring filter (9)	23
Scoring filter (8)	20
Scoring filter (10)	13
Too many newsgroups	6
Poison newsgroup	4
HTML post	2
Excessively crossposted test article	1
TOTAL: 10	5573

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	2224
	news.nask.pl	99
	TOTAL: 2	2323
TOTAL: 1		2323

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	42645	490	13792	243	19	41183	1%	23:59:57
2	icm	18543	17	16485	621	0	0	0%	23:59:51
3	poznan	9300	8	6436	24	0	0	0%	23:59:57
4	nask	6576	7	4775	0	0	0	0%	23:59:57
5	okapi	0	0	0	0	0	1328	0%	23:57:50
TOTAL: 5		77064	522	41488	888	19	42511	0%	119:57:32

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	1.5 MB	661.7 KB	2.1 MB	0.0 KB/s	3.0 KB	23:59:57
2	icm	1.1 MB	277.8 MB	278.9 MB	3.3 KB/s	447.7 KB	23:59:51
3	poznan	29.7 KB	50.5 KB	80.1 KB	0.0 KB/s	2.5 KB	23:59:57
4	nask	13.8 KB	0.0 KB	13.8 KB	0.0 KB/s	2.0 KB	23:59:57
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:50
TOTAL: 5		2.6 MB	278.5 MB	281.1 MB	0.7 KB/s	204.2 KB	119:57:32

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	287	14	14.5 KB	7	0	0	00:00:24
TOTAL: 1		287	14	14.5 KB	7	0	0	00:01:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.man.lodz.pl	671	14	14.5 KB	7	00:00:29
2	*.icpnet.pl	1	0	0.0 KB	0	00:00:31
TOTAL: 2		672	14	14.5 KB	7	00:01:00

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
d103-238.icpnet.pl	0.016	0.024	00:00:31
web.man.lodz.pl	1.120	4.132	00:00:24
mon.man.lodz.pl	1.028	3.700	00:00:04
david.man.lodz.pl	0.316	1.288	00:00:01
TOTAL: 4	2.480	9.144	00:01:00

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
d103-238.icpnet.pl	1
TOTAL: 3	385

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	12
2	pl.comp.pecet	2
TOTAL: 2		14

Daily Usenet report

Jun 17 04:15:02 -- Jun 18 04:15:02