Daily Usenet report: May 24 04:15:05

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

May 25 00:04:17 newsfeed nnrpd[19443]: SERVER perl filter not defined
May 25 01:03:30 newsfeed overchan[2610]: message repeated 78 times: [ input line too long, skipping]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2303922	96.4%	255.1 MB	95.9%
innfeed	45126	1.9%	5.3 MB	2.0%
innd	36214	1.5%	5.0 MB	1.9%
nnrpd	5087	0.2%	528.6 KB	0.2%
overchan	2	0.0%	0.1 KB	0.0%
controlchan	2	0.0%	0.3 KB	0.0%
TOTAL: 6	2390353	100.0%	265.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2297209	94.6%
Negative hits	114959	4.7%
Positive hits	16577	0.7%
Cache misses	106	0.0%
TOTAL: 4	2428851	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.026	0.0%	174	0.000	17.391	810.000
article cleanup	00:00:33.599	0.0%	2301704	0.006	0.015	0.029
article logging	00:01:12.557	0.1%	2302310	0.015	0.032	0.494
article parse	01:17:13.960	5.4%	204409560	0.012	0.023	0.076
article write	00:23:28.189	1.6%	2279883	0.330	0.618	3.573
artlog/artcncl	00:00:00.005	0.0%	163	0.000	0.031	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:43.935	0.2%	220371773	0.000	0.001	0.007
hisgrep/artcncl	00:00:00.266	0.0%	149	0.000	1.785	29.000
hishave/artcncl	00:00:00.139	0.0%	174	0.000	0.799	28.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:55:12.183	3.8%	2429651	0.080	1.363	37.756
history sync	00:00:00.018	0.0%	291	0.000	0.062	1.000
history write	01:14:28.031	5.2%	2298052	0.218	1.944	54.511
hiswrite/artcncl	00:00:00.097	0.0%	25	0.000	3.880	21.000
idle	12:37:16.305	52.6%	146916297	0.119	0.309	10.224
nntp read	01:18:03.910	5.4%	202695903	0.014	0.023	0.039
overview write	00:00:13.432	0.0%	2279883	0.001	0.006	0.018
perl filter	05:19:03.899	22.2%	2298052	5.450	8.330	12.472
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:02.698	0.3%	4591812	0.034	0.053	0.092
TOTAL: 23:59:13.453	23:13:36.249	96.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.230	0.0%	87091	0.000	0.003	0.125
article prepare	00:00:00.013	0.0%	38048	0.000	0.000	0.062
article read	00:01:03.971	0.1%	9450	0.000	6.769	488.000
backlog stats	00:00:00.206	0.0%	264909	0.000	0.001	0.020
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:01.807	0.0%	138177	0.000	0.013	0.167
data write	00:00:08.584	0.0%	122742	0.000	0.070	0.991
idle	23:58:11.461	99.9%	264909	101.711	325.740	1223.019
status file	00:00:15.762	0.0%	15905	0.167	0.991	90.417
TOTAL: 23:59:54.944	23:59:42.034	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.046	0.0%	978	0.047	0.047	0.047
idle	19:42:15.731	100.0%	92273	0.000	768.759	450027.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.982	0.0%	185448	0.000	0.021	1.037
readart	00:00:00.835	0.0%	1067	0.000	0.783	16.163
TOTAL: 19:42:38.183	19:42:20.594	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	148
name	2
newgroup	1
pause	2
paused	2
reload	2
reserve	2
TOTAL: 12	190

Newsgroups created:

Group	Mode
alt.society.covertconduct	y
TOTAL	1

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
kiltedrambler@gmail.com	1	0	0	0	1	1
TOTAL	1	0	0	0	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	848	2281071	2268682	8437	3952	99%	291:38:36
2	news.nask.pl	2	33861	11962	4178	17721	35%	23:57:00
3	news.icm.edu.pl	42	405	30	288	87	7%	16:51:12
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		894	2315338	2280675	12903	21760	98%	332:26:48

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	845.8 GB	33.8 MB	102.6 MB	845.9 GB	99%	390.3 KB
2	news.nask.pl	73.1 MB	1.5 MB	200.2 MB	274.8 MB	26%	9.5 KB
3	news.icm.edu.pl	966.7 KB	42.0 KB	1.8 MB	2.8 MB	34%	24.3 KB
4	localhost	1.5 KB	0.0 KB	0.0 KB	1.5 KB	100%	1.5 KB
TOTAL: 4		845.8 GB	35.3 MB	304.6 MB	846.2 GB	99%	385.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 24 04:15:05 - 04:59:59	72955	3.2%	27.07	25.5 GB	3.0%	9915.55
May 24 05:00:00 - 05:59:59	106510	4.7%	29.59	36.7 GB	4.3%	10688.13
May 24 06:00:00 - 06:59:59	99239	4.4%	27.57	35.1 GB	4.1%	10219.44
May 24 07:00:00 - 07:59:59	109269	4.8%	30.35	38.6 GB	4.6%	11256.32
May 24 08:00:00 - 08:59:59	100633	4.4%	27.95	40.1 GB	4.7%	11686.79
May 24 09:00:00 - 09:59:59	101515	4.4%	28.20	41.1 GB	4.9%	11967.12
May 24 10:00:00 - 10:59:59	105916	4.6%	29.42	42.8 GB	5.1%	12477.40
May 24 11:00:00 - 11:59:59	107009	4.7%	29.72	43.0 GB	5.1%	12537.29
May 24 12:00:00 - 12:59:59	101401	4.4%	28.17	41.8 GB	4.9%	12181.52
May 24 13:00:00 - 13:59:59	75376	3.3%	20.94	30.2 GB	3.6%	8794.18
May 24 14:00:00 - 14:59:59	90670	4.0%	25.19	35.3 GB	4.2%	10273.61
May 24 15:00:00 - 15:59:59	86438	3.8%	24.01	35.4 GB	4.2%	10325.25
May 24 16:00:00 - 16:59:59	86890	3.8%	24.14	35.7 GB	4.2%	10398.71
May 24 17:00:00 - 17:59:59	92726	4.1%	25.76	35.2 GB	4.2%	10251.40
May 24 18:00:00 - 18:59:59	92498	4.1%	25.69	35.2 GB	4.2%	10254.34
May 24 19:00:00 - 19:59:59	96367	4.2%	26.77	36.2 GB	4.3%	10535.78
May 24 20:00:00 - 20:59:59	105733	4.6%	29.37	33.1 GB	3.9%	9645.97
May 24 21:00:00 - 21:59:59	103347	4.5%	28.71	32.9 GB	3.9%	9584.24
May 24 22:00:00 - 22:59:59	89832	3.9%	24.95	29.4 GB	3.5%	8575.42
May 24 23:00:00 - 23:59:59	83124	3.6%	23.09	27.6 GB	3.3%	8040.11
May 25 00:00:00 - 00:59:59	75768	3.3%	21.05	27.5 GB	3.3%	8020.60
May 25 01:00:00 - 01:59:59	71585	3.1%	19.88	28.7 GB	3.4%	8371.11
May 25 02:00:00 - 02:59:59	99630	4.4%	27.68	35.7 GB	4.2%	10406.80
May 25 03:00:00 - 03:59:59	101121	4.4%	28.09	34.3 GB	4.1%	9987.55
May 25 04:00:00 - 04:15:02	25772	1.1%	28.57	8.2 GB	1.0%	9568.42
TOTAL: 23:59:57	2281324	100.0%	26.41	845.6 GB	100.0%	10262.83

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	17995	10	414	3	17568
2	newsfeed.pionier.net.pl	4353	153	3242	1	957
3	news.icm.edu.pl	87	0	1	0	86
TOTAL: 3		22435	163	3657	4	18611

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	89
it.comp.os.win.windows10	25
it.tlc.cellulari.android	22
it.comp.os.win.windows7	12
comp.sys.raspberry-pi	6
comp.mobile.android	4
alt.sex.telephones	2
hr.ponuda.hardver.komponente	1
it.comp.virtualizzazione	1
nl.comp.sys.android	1
TOTAL: 10	163

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

Groups	Count
pl.praca.oferowana	2
hr.alt.hackers	1
bit.listserv.catholic	1
TOTAL: 3	4

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	16712
Binary in non-binary group	694
PFM bot misc	213
Scoring filter (8)	107
EMP (phl)	72
Poison newsgroup	56
Scoring filter (9)	42
Scoring filter (10)	24
Scoring filter (14)	12
HTML post	11
Scoring filter (11)	11
Scoring filter (13)	9
Scoring filter (16)	8
Scoring filter (12)	8
Scoring filter (15)	5
Attached HTML file	3
EMP (fsl)	3
Scoring filter (17)	3
Excessively crossposted test article	3
Scoring filter (25)	2
TOTAL: 26	18005

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	61535	1787	32962	427	6	51905	2%	23:59:35
2	icm	38494	849	24686	5430	0	0	2%	24:07:29
3	poznan	19206	158	11798	27	0	1	0%	24:08:28
4	nask	8545	18	5401	0	0	0	0%	24:04:33
5	okapi	0	0	0	0	0	2160	0%	23:50:17
TOTAL: 5		127780	2812	74847	5884	6	54066	2%	120:10:22

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	11.9 MB	2.0 MB	13.9 MB	0.2 KB/s	6.4 KB	23:59:35
2	icm	7.7 MB	1.6 GB	1.6 GB	19.5 KB/s	269.2 KB	24:07:29
3	poznan	839.0 KB	100.9 KB	939.9 KB	0.0 KB/s	5.1 KB	24:08:28
4	nask	49.3 KB	0.0 KB	49.3 KB	0.0 KB/s	2.7 KB	24:04:33
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:17
TOTAL: 5		20.5 MB	1.6 GB	1.6 GB	3.9 KB/s	196.1 KB	120:10:22

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-212-51-218-225.p.lodz.pl	9	60	144.8 KB	8	0	02:02:59
2	web.man.lodz.pl	288	34	36.0 KB	17	0	00:00:21
3	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 3		298	94	180.8 KB	25	1	19:42:37

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.p.lodz.pl	9	60	144.8 KB	8	0	02:02:59
2	*.man.lodz.pl	673	34	36.0 KB	17	1	00:00:25
3	unresolved	4	0	0.0 KB	0	0	17:39:09
4	*.toya.net.pl	63	0	0.0 KB	0	0	00:00:03
TOTAL: 4		749	94	180.8 KB	25	1	19:42:37

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.194.74	5.495	7.594	17:39:09
pc-212-51-218-225.p.lodz.pl	0.035	0.186	02:02:59
web.man.lodz.pl	1.033	4.736	00:00:21
staticline41435.toya.net.pl	0.220	1.003	00:00:03
mon.man.lodz.pl	0.873	4.741	00:00:03
david.man.lodz.pl	0.318	1.540	00:00:01
isvcs01.man.lodz.pl	0.000	0.017	00:00:00
TOTAL: 7	7.974	19.817	19:42:37

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	63
185.48.194.74	4
TOTAL: 4	451

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	3	1
185.48.194.74	1	0
TOTAL: 2	4	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.misc.elektronika	44
2	pl.comp.os.ms-windows.winnt	26
3	pl.misc.kolej	16
4	pl.comp.pecet	8
TOTAL: 4		94

Daily Usenet report

May 24 04:15:05 -- May 25 04:15:02