Daily Usenet report: Jun 24 04:15:02

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Jun 24 05:09:29 newsfeed overchan[8999]: input line too long, skipping
Jun 24 05:14:38 newsfeed overchan[8999]: input line too long, skipping
Jun 24 05:59:43 newsfeed overchan[8999]: input line too long, skipping
Jun 24 08:56:45 newsfeed nnrpd[19832]: SERVER perl filter not defined
Jun 24 09:15:06 newsfeed nnrpd[20545]: SERVER perl filter not defined
Jun 24 13:31:46 newsfeed nnrpd[29910]: SERVER perl filter not defined
Jun 24 16:50:28 newsfeed nnrpd[4963]: SERVER perl filter not defined
Jun 25 01:50:04 newsfeed overchan[8999]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3048313	97.7%	355.0 MB	97.4%
innfeed	44027	1.4%	5.2 MB	1.4%
innd	23963	0.8%	3.8 MB	1.0%
nnrpd	4804	0.2%	507.0 KB	0.1%
overchan	5	0.0%	0.8 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3121113	100.0%	364.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3000126	79.9%
Negative hits	691806	18.4%
Positive hits	63580	1.7%
Cache misses	353	0.0%
TOTAL: 4	3755865	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.436	0.0%	156	0.000	9.205	198.500
article cleanup	00:00:38.089	0.0%	3047550	0.009	0.012	0.018
article logging	00:01:46.641	0.1%	3048150	0.025	0.035	0.100
article parse	01:04:06.469	4.5%	215198012	0.013	0.018	0.034
article write	00:21:23.448	1.5%	3030488	0.344	0.424	0.657
artlog/artcncl	00:00:00.013	0.0%	154	0.000	0.084	0.450
artlog/artparse	00:00:00.000	0.0%	6	0.000	0.000	0.000
data move	00:03:04.871	0.2%	233961971	0.001	0.001	0.003
hisgrep/artcncl	00:00:00.205	0.0%	136	0.000	1.507	13.000
hishave/artcncl	00:00:00.213	0.0%	156	0.000	1.365	19.667
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:46:17.726	3.2%	3795164	0.015	0.732	8.176
history sync	00:00:00.010	0.0%	290	0.000	0.034	1.500
history write	02:14:11.871	9.3%	3034939	0.153	2.653	12.321
hiswrite/artcncl	00:00:00.200	0.0%	20	1.000	10.000	13.800
idle	12:26:57.485	51.9%	133075773	0.208	0.337	0.643
nntp read	01:08:39.043	4.8%	212826448	0.015	0.019	0.026
overview write	00:00:14.755	0.0%	3030488	0.003	0.005	0.007
perl filter	05:21:28.342	22.3%	3034933	5.536	6.355	7.375
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:44.322	0.3%	6163948	0.038	0.046	0.062
TOTAL: 24:00:03.067	23:33:35.139	98.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.512	0.0%	215325	0.000	0.002	0.020
article prepare	00:00:00.001	0.0%	8126	0.000	0.000	0.025
article read	00:00:40.144	0.0%	2024	0.000	19.834	362.750
backlog stats	00:00:00.329	0.0%	502783	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	8	0.000	0.000	0.000
data read	00:00:04.773	0.0%	321199	0.006	0.015	0.055
data write	00:00:08.905	0.0%	219776	0.012	0.041	0.109
idle	24:02:46.673	99.9%	502783	45.010	172.175	1106.242
status file	00:00:12.382	0.0%	16349	0.466	0.757	2.117
TOTAL: 24:04:13.545	24:03:53.719	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:48.195	78.9%	3078	0.000	15.658	7046.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.146	0.2%	6858	0.000	0.021	0.500
readart	00:00:00.011	0.0%	68	0.000	0.162	3.000
TOTAL: 00:01:01.069	00:00:48.352	79.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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	941	3029736	2968563	48709	12464	97%	455:39:18
2	news.nask.pl	2	68241	61271	2380	4590	89%	24:12:35
3	news.icm.edu.pl	39	299	38	222	39	12%	17:03:17
4	localhost	5	4	4	0	0	100%	00:00:01
TOTAL: 4		987	3098280	3029876	51311	17093	97%	496:55:11

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	883.1 GB	3.0 GB	3.0 GB	889.0 GB	99%	312.7 KB
2	news.nask.pl	17.6 GB	1.6 MB	27.4 MB	17.6 GB	99%	280.1 KB
3	news.icm.edu.pl	1.1 MB	0.0 KB	2.8 MB	3.9 MB	27%	51.7 KB
4	localhost	5.7 KB	0.0 KB	0.0 KB	5.7 KB	100%	1.4 KB
TOTAL: 4		900.6 GB	3.0 GB	3.0 GB	906.6 GB	99%	312.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 24 04:15:02 - 04:59:59	86901	2.9%	32.21	29.0 GB	3.2%	11289.34
Jun 24 05:00:00 - 05:59:59	121969	4.0%	33.88	39.3 GB	4.4%	11454.73
Jun 24 06:00:00 - 06:59:59	130650	4.3%	36.29	40.0 GB	4.5%	11663.13
Jun 24 07:00:00 - 07:59:59	139764	4.6%	38.82	41.7 GB	4.6%	12147.31
Jun 24 08:00:00 - 08:59:59	142306	4.7%	39.53	42.2 GB	4.7%	12297.10
Jun 24 09:00:00 - 09:59:59	119307	3.9%	33.14	35.0 GB	3.9%	10194.88
Jun 24 10:00:00 - 10:59:59	86880	2.9%	24.13	25.0 GB	2.8%	7274.60
Jun 24 11:00:00 - 11:59:59	109168	3.6%	30.32	32.1 GB	3.6%	9358.31
Jun 24 12:00:00 - 12:59:59	138349	4.6%	38.43	40.5 GB	4.5%	11800.82
Jun 24 13:00:00 - 13:59:59	136004	4.5%	37.78	40.3 GB	4.5%	11727.79
Jun 24 14:00:00 - 14:59:59	140515	4.6%	39.03	41.4 GB	4.6%	12073.08
Jun 24 15:00:00 - 15:59:59	139860	4.6%	38.85	41.2 GB	4.6%	12014.84
Jun 24 16:00:00 - 16:59:59	134935	4.5%	37.48	39.9 GB	4.4%	11625.67
Jun 24 17:00:00 - 17:59:59	131767	4.3%	36.60	38.8 GB	4.3%	11289.04
Jun 24 18:00:00 - 18:59:59	132452	4.4%	36.79	39.3 GB	4.4%	11447.91
Jun 24 19:00:00 - 19:59:59	114526	3.8%	31.81	35.3 GB	3.9%	10287.62
Jun 24 20:00:00 - 20:59:59	127819	4.2%	35.51	38.3 GB	4.3%	11165.46
Jun 24 21:00:00 - 21:59:59	139200	4.6%	38.67	41.0 GB	4.6%	11929.11
Jun 24 22:00:00 - 22:59:59	133210	4.4%	37.00	38.7 GB	4.3%	11276.48
Jun 24 23:00:00 - 23:59:59	118614	3.9%	32.95	33.3 GB	3.7%	9712.80
Jun 25 00:00:00 - 00:59:59	113275	3.7%	31.47	32.5 GB	3.6%	9466.74
Jun 25 01:00:00 - 01:59:59	134986	4.5%	37.50	39.5 GB	4.4%	11512.35
Jun 25 02:00:00 - 02:59:59	105284	3.5%	29.25	30.9 GB	3.4%	8994.41
Jun 25 03:00:00 - 03:59:59	120863	4.0%	33.57	34.9 GB	3.9%	10165.97
Jun 25 04:00:00 - 04:15:02	31898	1.1%	35.36	9.3 GB	1.0%	10838.55
TOTAL: 24:00:00	3030502	100.0%	35.08	899.7 GB	100.0%	10919.02

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	12817	150	12250	2	415
2	news.nask.pl	4801	28	346	5	4422
3	news.icm.edu.pl	39	0	0	0	39
TOTAL: 3		17657	178	12596	7	4876

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it.comp.os.win.windows10	84
uk.railway	37
comp.mobile.android	34
it.tlc.cellulari.android	17
de.comp.lang.php	4
hr.ponuda.hardver.komponente	1
de.rec.sf.startrek	1
TOTAL: 7	178

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

Groups	Count
pl.praca.oferowana	5
pl.sci.matematyka	1
bit.listserv.catholic	1
TOTAL: 3	7

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	4017
Binary in non-binary group	101
Scoring filter (9)	36
Scoring filter (8)	34
Scoring filter (13)	17
Scoring filter (10)	17
EMP (phl)	16
Scoring filter (12)	10
Scoring filter (11)	6
EMP (fsl)	6
Poison newsgroup	5
Scoring filter (15)	2
HTML post	2
Too many newsgroups	2
Scoring filter (14)	2
Scoring filter (19)	1
TOTAL: 16	4274

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	348
	news.nask.pl	248
	TOTAL: 2	596
TOTAL: 1		596

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	121769	533	93736	374	33	121960	0%	23:59:58
2	nask	37660	110	36230	1	0	0	0%	23:58:00
3	poznan	12748	97	8390	32	0	0	0%	23:59:37
4	icm	111335	68	101976	399	0	0	0%	23:59:58
5	okapi	0	0	0	0	0	1496	0%	23:57:50
TOTAL: 5		283512	808	240332	806	33	123456	0%	119:55:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	31.1 MB	354.0 KB	31.4 MB	0.4 KB/s	290.0 KB	23:58:00
2	panorama	13.2 MB	20.2 MB	33.4 MB	0.4 KB/s	37.7 KB	23:59:58
3	poznan	704.4 KB	98.1 KB	802.5 KB	0.0 KB/s	6.2 KB	23:59:37
4	icm	196.8 KB	183.8 MB	184.0 MB	2.2 KB/s	403.5 KB	23:59:58
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:50
TOTAL: 5		45.2 MB	204.5 MB	249.7 MB	0.6 KB/s	158.4 KB	119:55:23

Backlog files shrunk by innfeed:

Server	Size
panorama	4.3 MB
TOTAL: 1	4.3 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	68	60.0 KB	32	0	00:00:25
2	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:01
TOTAL: 2		292	68	60.0 KB	32	4	00:01:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	676	68	60.0 KB	32	4	00:00:32
2	*.neoplus.adsl.tpnet.pl	1	0	0.0 KB	0	0	00:00:28
TOTAL: 2		677	68	60.0 KB	32	4	00:01:00

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
actk220.neoplus.adsl.tpnet.pl	0.032	0.016	00:00:28
web.man.lodz.pl	1.196	3.500	00:00:25
mon.man.lodz.pl	0.984	3.500	00:00:03
isvcs01.man.lodz.pl	0.012	0.044	00:00:01
david.man.lodz.pl	0.288	1.264	00:00:01
TOTAL: 5	2.512	8.324	00:01:00

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
actk220.neoplus.adsl.tpnet.pl	1
TOTAL: 3	385

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Jun 24 04:15:02 -- Jun 25 04:15:02