Daily Usenet report: May 19 04:15:02

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

May 19 05:19:19 newsfeed overchan[5659]: input line too long, skipping
May 19 06:36:44 newsfeed overchan[5659]: input line too long, skipping
May 19 09:05:32 newsfeed nnrpd[17258]: SERVER perl filter not defined
May 19 09:07:21 newsfeed nnrpd[17284]: SERVER perl filter not defined
May 19 09:52:38 newsfeed nnrpd[18995]: SERVER perl filter not defined
May 19 10:38:11 newsfeed nnrpd[20601]: SERVER perl filter not defined
May 19 11:46:36 newsfeed nnrpd[23139]: SERVER perl filter not defined
May 19 12:27:05 newsfeed nnrpd[24618]: SERVER perl filter not defined
May 19 12:28:08 newsfeed nnrpd[24655]: SERVER perl filter not defined
May 19 12:49:33 newsfeed overchan[5659]: input line too long, skipping
May 19 14:39:27 newsfeed overchan[5659]: input line too long, skipping
May 19 14:52:08 newsfeed nnrpd[30132]: SERVER perl filter not defined
May 19 14:55:45 newsfeed nnrpd[30221]: SERVER perl filter not defined
May 19 15:19:06 newsfeed nnrpd[31100]: SERVER perl filter not defined
May 20 02:21:20 newsfeed overchan[5659]: input line too long, skipping
May 20 02:21:38 newsfeed overchan[5659]: input line too long, skipping
May 20 02:23:33 newsfeed overchan[5659]: input line too long, skipping
May 20 02:23:58 newsfeed overchan[5659]: input line too long, skipping
May 20 02:28:07 newsfeed overchan[5659]: input line too long, skipping
May 20 02:28:24 newsfeed overchan[5659]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2109752	96.6%	244.9 MB	96.3%
innfeed	47682	2.2%	5.6 MB	2.2%
innd	20686	0.9%	3.2 MB	1.3%
nnrpd	4855	0.2%	511.3 KB	0.2%
overchan	11	0.0%	1.9 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2182987	100.0%	254.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2089387	96.2%
Negative hits	68363	3.1%
Positive hits	12984	0.6%
Cache misses	108	0.0%
TOTAL: 4	2170842	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.184	0.0%	209	0.000	10.450	86.000
article cleanup	00:00:29.355	0.0%	2110213	0.010	0.014	0.020
article logging	00:01:23.536	0.1%	2110756	0.029	0.040	0.210
article parse	00:54:51.313	3.8%	169097817	0.013	0.019	0.030
article write	00:27:08.171	1.9%	2099390	0.387	0.776	4.658
artlog/artcncl	00:00:00.006	0.0%	208	0.000	0.029	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:22.584	0.2%	182977318	0.001	0.001	0.001
hisgrep/artcncl	00:00:00.339	0.0%	189	0.000	1.794	38.000
hishave/artcncl	00:00:00.573	0.0%	209	0.000	2.742	44.200
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:35:01.529	2.4%	2189235	0.059	0.960	5.613
history sync	00:00:00.025	0.0%	290	0.000	0.086	0.500
history write	01:44:26.973	7.3%	2105646	0.449	2.976	8.320
hiswrite/artcncl	00:00:00.391	0.0%	20	1.000	19.550	24.444
idle	14:13:27.587	59.3%	128877705	0.202	0.397	0.688
nntp read	01:07:44.268	4.7%	167505606	0.018	0.024	0.035
overview write	00:00:11.226	0.0%	2099390	0.004	0.005	0.008
perl filter	04:03:11.668	16.9%	2105646	6.359	6.930	8.369
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:37.495	0.3%	4259160	0.037	0.051	0.115
TOTAL: 24:00:02.728	23:13:59.223	96.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.379	0.0%	125229	0.000	0.003	0.018
article prepare	00:00:00.049	0.0%	164824	0.000	0.000	0.015
article read	00:01:35.737	0.1%	41196	0.157	2.324	444.000
backlog stats	00:00:00.322	0.0%	349490	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	4	0.000	0.000	0.000
data read	00:00:03.281	0.0%	184865	0.002	0.018	0.045
data write	00:00:55.963	0.1%	160599	0.018	0.348	0.715
idle	23:51:00.517	99.8%	349490	23.112	245.674	1007.874
status file	00:00:14.437	0.0%	16320	0.625	0.885	2.008
TOTAL: 23:54:06.370	23:53:50.685	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:23:05.356	99.1%	3138	0.000	441.477	456002.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.177	0.0%	6962	0.000	0.025	0.667
readart	00:00:00.004	0.0%	82	0.000	0.049	0.500
TOTAL: 00:23:17.253	00:23:05.537	99.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	845	2098212	2090335	3465	4412	99%	346:45:46
2	news.nask.pl	2	18686	7857	4621	6208	42%	23:51:52
3	news.icm.edu.pl	44	509	24	295	190	4%	15:58:12
4	localhost	11	10	10	0	0	100%	00:00:00
TOTAL: 4		902	2117417	2098226	8381	10810	99%	386:35:50

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	687.9 GB	21.5 MB	24.6 MB	688.0 GB	99%	344.4 KB
2	news.nask.pl	32.7 MB	1.1 MB	41.6 MB	75.3 MB	43%	5.5 KB
3	news.icm.edu.pl	442.8 KB	72.1 KB	1.9 MB	2.4 MB	18%	11.4 KB
4	localhost	15.9 KB	0.0 KB	0.0 KB	15.9 KB	100%	1.6 KB
TOTAL: 4		688.0 GB	22.6 MB	68.1 MB	688.1 GB	99%	342.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 19 04:15:02 - 04:59:59	84043	4.0%	31.15	28.7 GB	4.2%	11157.83
May 19 05:00:00 - 05:59:59	113625	5.4%	31.56	40.4 GB	5.9%	11758.11
May 19 06:00:00 - 06:59:59	129261	6.2%	35.91	40.8 GB	5.9%	11896.46
May 19 07:00:00 - 07:59:59	78611	3.7%	21.84	26.5 GB	3.9%	7723.59
May 19 08:00:00 - 08:59:59	54525	2.6%	15.15	20.1 GB	2.9%	5859.77
May 19 09:00:00 - 09:59:59	57810	2.8%	16.06	20.2 GB	2.9%	5878.17
May 19 10:00:00 - 10:59:59	52668	2.5%	14.63	19.0 GB	2.8%	5540.79
May 19 11:00:00 - 11:59:59	51114	2.4%	14.20	17.4 GB	2.5%	5056.04
May 19 12:00:00 - 12:59:59	51680	2.5%	14.36	18.4 GB	2.7%	5354.10
May 19 13:00:00 - 13:59:59	100227	4.8%	27.84	33.0 GB	4.8%	9613.78
May 19 14:00:00 - 14:59:59	102488	4.9%	28.47	34.5 GB	5.0%	10054.14
May 19 15:00:00 - 15:59:59	134786	6.4%	37.44	42.6 GB	6.2%	12408.94
May 19 16:00:00 - 16:59:59	140677	6.7%	39.08	43.1 GB	6.3%	12559.27
May 19 17:00:00 - 17:59:59	117896	5.6%	32.75	36.5 GB	5.3%	10639.28
May 19 18:00:00 - 18:59:59	120610	5.7%	33.50	37.8 GB	5.5%	11006.94
May 19 19:00:00 - 19:59:59	70489	3.4%	19.58	25.2 GB	3.7%	7337.61
May 19 20:00:00 - 20:59:59	70876	3.4%	19.69	25.6 GB	3.7%	7452.21
May 19 21:00:00 - 21:59:59	70645	3.4%	19.62	24.4 GB	3.5%	7095.70
May 19 22:00:00 - 22:59:59	65568	3.1%	18.21	22.7 GB	3.3%	6603.93
May 19 23:00:00 - 23:59:59	56527	2.7%	15.70	18.5 GB	2.7%	5393.08
May 20 00:00:00 - 00:59:59	88857	4.2%	24.68	27.0 GB	3.9%	7853.14
May 20 01:00:00 - 01:59:59	96949	4.6%	26.93	27.6 GB	4.0%	8032.01
May 20 02:00:00 - 02:59:59	102720	4.9%	28.53	29.4 GB	4.3%	8557.79
May 20 03:00:00 - 03:59:59	75154	3.6%	20.88	24.4 GB	3.6%	7118.05
May 20 04:00:00 - 04:15:02	10365	0.5%	11.49	3.8 GB	0.5%	4395.82
TOTAL: 24:00:00	2098171	100.0%	24.28	687.5 GB	100.0%	8344.02

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	6335	50	418	3	5864
2	newsfeed.pionier.net.pl	4847	176	4147	1	523
3	news.icm.edu.pl	191	0	2	0	189
TOTAL: 3		11373	226	4567	4	6576

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	92
comp.mobile.android	64
it.tlc.cellulari.android	29
it.comp.os.win.windows10	15
comp.sys.raspberry-pi	14
uk.rec.cycling.moderated	5
it.discussioni.energia	2
de.rec.sf.startrek	1
alt.sex.telephones	1
hr.ponuda.hardver.komponente	1
it.comp.virtualizzazione	1
it.comp.os.win.windows7	1
TOTAL: 12	226

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	5156
EMP (phl)	648
Binary in non-binary group	151
Scoring filter (8)	38
Scoring filter (9)	25
Scoring filter (10)	7
HTML post	4
Scoring filter (12)	1
Scoring filter (17)	1
Scoring filter (11)	1
Too many newsgroups	1
TOTAL: 11	6033

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	435
	news.nask.pl	107
	news.icm.edu.pl	1
	TOTAL: 3	543
TOTAL: 1		543

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	66649	37860	20098	1302	0	1	56%	23:59:58
2	panorama	68403	877	39998	404	10	84095	1%	23:59:58
3	poznan	11893	101	7663	40	0	0	0%	23:59:52
4	nask	8866	10	5919	1	0	0	0%	23:59:58
5	okapi	0	0	0	0	0	2053	0%	23:57:50
TOTAL: 5		155811	38848	73678	1747	10	86149	24%	119:57:36

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	6.8 GB	211.0 MB	7.0 GB	84.6 KB/s	186.7 KB	23:59:58
2	panorama	2.4 MB	1.3 MB	3.7 MB	0.0 KB/s	3.0 KB	23:59:58
3	poznan	700.4 KB	126.4 KB	826.8 KB	0.0 KB/s	5.9 KB	23:59:52
4	nask	19.2 KB	2.7 KB	21.9 KB	0.0 KB/s	2.0 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		6.8 GB	212.4 MB	7.0 GB	16.9 KB/s	180.3 KB	119:57:36

Backlog files shrunk by innfeed:

Server	Size
okapi	488.4 KB
TOTAL: 1	488.4 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	82	66.7 KB	35	0	00:00:22
2	isvcs01.man.lodz.pl	10	0	0.0 KB	0	10	00:00:01
TOTAL: 2		298	82	66.7 KB	35	10	00:23:16

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	682	82	66.7 KB	35	10	00:00:28
2	*.p.lodz.pl	1	0	0.0 KB	0	0	00:22:48
TOTAL: 2		683	82	66.7 KB	35	10	00:23:16

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-191-92-113.p.lodz.pl	0.000	0.012	00:22:48
web.man.lodz.pl	1.180	4.888	00:00:22
mon.man.lodz.pl	1.060	4.720	00:00:03
david.man.lodz.pl	0.356	1.576	00:00:01
isvcs01.man.lodz.pl	0.076	0.196	00:00:01
TOTAL: 5	2.672	11.392	00:23:16

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
pc-212-191-92-113.p.lodz.pl	1
TOTAL: 3	385

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

May 19 04:15:02 -- May 20 04:15:02