Daily Usenet report: Apr 23 04:15:04

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Apr 23 05:52:04 newsfeed overchan[480]: input line too long, skipping
Apr 23 05:52:22 newsfeed overchan[480]: input line too long, skipping
Apr 23 05:52:39 newsfeed overchan[480]: input line too long, skipping
Apr 23 05:52:57 newsfeed overchan[480]: input line too long, skipping
Apr 23 05:53:18 newsfeed overchan[480]: input line too long, skipping
Apr 23 09:36:54 newsfeed nnrpd[12894]: SERVER perl filter not defined
Apr 23 09:43:45 newsfeed overchan[480]: input line too long, skipping
Apr 23 13:28:03 newsfeed overchan[480]: input line too long, skipping
Apr 23 14:07:59 newsfeed overchan[480]: input line too long, skipping
Apr 23 16:42:15 newsfeed nnrpd[28551]: SERVER perl filter not defined
Apr 23 18:05:52 newsfeed overchan[480]: input line too long, skipping
Apr 23 18:07:21 newsfeed overchan[480]: input line too long, skipping
Apr 23 18:07:38 newsfeed overchan[480]: input line too long, skipping
Apr 23 18:08:44 newsfeed overchan[480]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2899982	97.4%	338.3 MB	97.2%
innfeed	39691	1.3%	4.7 MB	1.3%
innd	32431	1.1%	4.5 MB	1.3%
nnrpd	4750	0.2%	501.0 KB	0.1%
overchan	13	0.0%	2.3 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2976868	100.0%	347.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2881562	97.2%
Negative hits	70247	2.4%
Positive hits	11555	0.4%
Cache misses	119	0.0%
TOTAL: 4	2963483	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:06.906	0.0%	219	0.000	31.534	666.667
article cleanup	00:00:34.367	0.0%	2899478	0.009	0.012	0.016
article logging	00:01:46.512	0.1%	2899953	0.025	0.037	0.218
article parse	01:10:17.124	4.9%	240462157	0.012	0.018	0.028
article write	00:43:56.392	3.1%	2881410	0.365	0.915	3.873
artlog/artcncl	00:00:00.004	0.0%	210	0.000	0.019	0.143
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:03:01.824	0.2%	259272323	0.001	0.001	0.001
hisgrep/artcncl	00:00:00.589	0.0%	208	0.000	2.832	41.500
hishave/artcncl	00:00:00.070	0.0%	219	0.000	0.320	4.571
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:28:59.179	2.0%	2978634	0.110	0.584	4.500
history sync	00:00:00.019	0.0%	290	0.000	0.066	1.000
history write	01:20:33.800	5.6%	2894931	0.205	1.670	6.995
hiswrite/artcncl	00:00:00.021	0.0%	11	0.000	1.909	3.000
idle	12:21:07.941	51.5%	167614799	0.208	0.265	0.347
nntp read	01:23:35.893	5.8%	238211297	0.017	0.021	0.027
overview write	00:00:14.793	0.0%	2881410	0.003	0.005	0.007
perl filter	05:27:44.104	22.8%	2894931	5.556	6.793	7.639
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:27.490	0.3%	5891813	0.029	0.045	0.092
TOTAL: 24:00:03.452	23:06:27.028	96.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.626	0.0%	211377	0.000	0.003	0.014
article prepare	00:00:00.127	0.0%	449836	0.000	0.000	0.003
article read	00:01:23.239	0.1%	112439	0.000	0.740	175.619
backlog stats	00:00:00.633	0.0%	684713	0.000	0.001	0.007
callbacks	00:00:00.000	0.0%	19	0.000	0.000	0.000
data read	00:00:05.783	0.0%	343688	0.004	0.017	0.038
data write	00:02:05.028	0.1%	345431	0.012	0.362	0.524
idle	23:48:40.331	99.7%	684713	19.715	125.192	1002.437
status file	00:00:11.912	0.0%	13887	0.544	0.858	1.283
TOTAL: 23:52:52.908	23:52:27.679	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:18.035	56.4%	3025	0.000	5.962	103.077
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.165	0.5%	6684	0.000	0.025	2.333
readart	00:00:00.002	0.0%	34	0.000	0.059	0.500
TOTAL: 00:00:31.987	00:00:18.202	56.9%	-	-	-	-

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	957	2882205	2873513	3154	5538	99%	411:50:06
2	news.nask.pl	2	23860	7650	3581	12629	32%	24:01:00
3	news.icm.edu.pl	45	269	16	247	6	5%	17:29:37
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		1007	2906336	2881181	6982	18173	99%	453:20:43

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	926.8 GB	50.4 MB	267.4 MB	927.1 GB	99%	337.7 KB
2	news.nask.pl	46.6 MB	1.4 MB	156.9 MB	205.0 MB	22%	10.3 KB
3	news.icm.edu.pl	290.1 KB	8.5 KB	203.4 KB	502.0 KB	57%	22.8 KB
4	localhost	2.8 KB	0.0 KB	0.0 KB	2.8 KB	100%	1.4 KB
TOTAL: 4		926.9 GB	51.9 MB	424.5 MB	927.3 GB	99%	335.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 23 04:15:04 - 04:59:59	86500	3.0%	32.08	26.7 GB	2.9%	10396.83
Apr 23 05:00:00 - 05:59:59	116742	4.1%	32.43	36.0 GB	3.9%	10479.75
Apr 23 06:00:00 - 06:59:59	117453	4.1%	32.63	36.8 GB	4.0%	10707.33
Apr 23 07:00:00 - 07:59:59	118871	4.1%	33.02	39.7 GB	4.3%	11564.77
Apr 23 08:00:00 - 08:59:59	149887	5.2%	41.64	39.3 GB	4.2%	11461.29
Apr 23 09:00:00 - 09:59:59	129253	4.5%	35.90	40.7 GB	4.4%	11866.10
Apr 23 10:00:00 - 10:59:59	125763	4.4%	34.93	40.8 GB	4.4%	11894.60
Apr 23 11:00:00 - 11:59:59	130412	4.5%	36.23	38.5 GB	4.2%	11199.78
Apr 23 12:00:00 - 12:59:59	134384	4.7%	37.33	40.2 GB	4.3%	11719.59
Apr 23 13:00:00 - 13:59:59	122622	4.3%	34.06	41.2 GB	4.4%	11997.29
Apr 23 14:00:00 - 14:59:59	112393	3.9%	31.22	39.6 GB	4.3%	11539.45
Apr 23 15:00:00 - 15:59:59	106190	3.7%	29.50	37.3 GB	4.0%	10850.83
Apr 23 16:00:00 - 16:59:59	111841	3.9%	31.07	38.8 GB	4.2%	11292.34
Apr 23 17:00:00 - 17:59:59	116748	4.1%	32.43	39.7 GB	4.3%	11569.12
Apr 23 18:00:00 - 18:59:59	134897	4.7%	37.47	37.9 GB	4.1%	11038.14
Apr 23 19:00:00 - 19:59:59	115798	4.0%	32.17	38.4 GB	4.1%	11184.92
Apr 23 20:00:00 - 20:59:59	113053	3.9%	31.40	38.5 GB	4.2%	11215.60
Apr 23 21:00:00 - 21:59:59	117816	4.1%	32.73	41.1 GB	4.4%	11984.53
Apr 23 22:00:00 - 22:59:59	119243	4.1%	33.12	40.1 GB	4.3%	11675.34
Apr 23 23:00:00 - 23:59:59	122123	4.2%	33.92	39.8 GB	4.3%	11586.56
Apr 24 00:00:00 - 00:59:59	111204	3.9%	30.89	32.9 GB	3.5%	9576.84
Apr 24 01:00:00 - 01:59:59	115034	4.0%	31.95	35.9 GB	3.9%	10469.26
Apr 24 02:00:00 - 02:59:59	117860	4.1%	32.74	40.6 GB	4.4%	11828.20
Apr 24 03:00:00 - 03:59:59	107360	3.7%	29.82	36.2 GB	3.9%	10541.08
Apr 24 04:00:00 - 04:15:02	27785	1.0%	30.80	9.6 GB	1.0%	11177.44
TOTAL: 23:59:58	2881232	100.0%	33.35	926.4 GB	100.0%	11243.15

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	12693	28	308	7	12350
2	newsfeed.pionier.net.pl	5840	90	4235	2	1513
3	news.icm.edu.pl	7	0	1	0	6
TOTAL: 3		18540	118	4544	9	13869

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it.tlc.cellulari.android	27
uk.railway	26
comp.mobile.android	22
comp.sys.raspberry-pi	14
it.comp.os.win.windows10	10
it.comp.os.win.windows7	7
nl.comp.sys.android	5
de.comm.software.mailreader	2
de.comp.lang.vbclassic	2
hr.ponuda.hardver.komponente	1
gmane.comp.gis.openstreetmap.legal	1
alt.sex.telephones	1
TOTAL: 12	118

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

Groups	Count
pl.sci.matematyka	8
bit.listserv.catholic	1
TOTAL: 2	9

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11850
Binary in non-binary group	1374
Scoring filter (8)	52
Poison newsgroup	38
Scoring filter (9)	28
EMP (phl)	14
Scoring filter (10)	10
Too many newsgroups	8
HTML post	6
Scoring filter (15)	5
Scoring filter (12)	3
Excessively crossposted test article	2
Scoring filter (11)	2
Scoring filter (13)	1
Attached HTML file	1
TOTAL: 15	13394

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	311
	news.nask.pl	163
	news.icm.edu.pl	1
	TOTAL: 3	475
TOTAL: 1		475

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	121944	97238	16478	4648	1	1	79%	23:59:45
2	panorama	96879	706	72699	425	51	137967	0%	23:59:55
3	poznan	11627	182	7320	64	0	0	1%	23:59:20
4	nask	15477	15	4585	8697	0	1	0%	23:59:55
5	okapi	0	0	0	0	0	1203	0%	23:57:48
TOTAL: 5		245927	98141	101082	13834	52	139172	39%	119:56:43

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	17.5 GB	760.7 MB	18.2 GB	221.4 KB/s	187.7 KB	23:59:45
2	panorama	2.4 MB	1.8 MB	4.3 MB	0.1 KB/s	3.9 KB	23:59:55
3	poznan	901.1 KB	340.9 KB	1.2 MB	0.0 KB/s	5.0 KB	23:59:20
4	nask	28.5 KB	3.2 GB	3.2 GB	38.9 KB/s	385.4 KB	23:59:55
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:48
TOTAL: 5		17.5 GB	3.9 GB	21.4 GB	52.1 KB/s	200.8 KB	119:56:43

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	34	27.7 KB	16	0	00:00:24
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:01
TOTAL: 2		290	34	27.7 KB	16	2	00:00:31

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	674	34	27.7 KB	16	2	0	00:00:31
TOTAL: 1		674	34	27.7 KB	16	2	0	00:00:31

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.160	4.836	00:00:24
mon.man.lodz.pl	0.996	4.148	00:00:04
david.man.lodz.pl	0.336	1.368	00:00:01
isvcs01.man.lodz.pl	0.016	0.040	00:00:01
TOTAL: 4	2.508	10.392	00:00:31

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

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

Newsgroup		Count
1	pl.comp.pecet	28
2	pl.comp.os.ms-windows.winnt	6
TOTAL: 2		34

Daily Usenet report

Apr 23 04:15:04 -- Apr 24 04:15:02