Daily Usenet report: Mar 11 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Mar 11 08:24:18 newsfeed nnrpd[16262]: SERVER perl filter not defined
Mar 11 11:02:12 newsfeed overchan[6316]: input line too long, skipping
Mar 11 11:08:20 newsfeed overchan[6316]: input line too long, skipping
Mar 11 16:00:02 newsfeed pgpverify[451]: pgpverify: verification failed
Mar 11 16:00:03 newsfeed pgpverify[498]: pgpverify: verification failed
Mar 11 21:30:24 newsfeed overchan[6316]: input line too long, skipping
Mar 11 21:38:45 newsfeed overchan[6316]: input line too long, skipping
Mar 12 00:32:27 newsfeed overchan[6316]: input line too long, skipping
Mar 12 02:51:25 newsfeed overchan[6316]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2896328	98.2%	320.5 MB	97.9%
innfeed	27035	0.9%	3.2 MB	1.0%
innd	19809	0.7%	3.2 MB	1.0%
nnrpd	4747	0.2%	500.7 KB	0.1%
overchan	7	0.0%	1.1 KB	0.0%
controlchan	3	0.0%	0.2 KB	0.0%
pgpverify	2	0.0%	0.1 KB	0.0%
TOTAL: 7	2947931	100.0%	327.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2857292	96.9%
Negative hits	81962	2.8%
Positive hits	10080	0.3%
Cache misses	126	0.0%
TOTAL: 4	2949460	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.849	0.0%	263	0.000	10.833	363.000
article cleanup	00:00:35.747	0.0%	2889704	0.009	0.012	0.016
article logging	00:02:04.426	0.1%	2890275	0.033	0.043	0.205
article parse	00:37:22.156	2.6%	71792534	0.023	0.031	0.043
article write	00:15:50.352	1.1%	2884900	0.160	0.329	0.599
artlog/artcncl	00:00:00.002	0.0%	246	0.000	0.008	0.333
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:01:30.821	0.1%	85594295	0.001	0.001	0.002
hisgrep/artcncl	00:00:00.596	0.0%	247	0.000	2.413	183.000
hishave/artcncl	00:00:00.267	0.0%	263	0.000	1.015	36.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:34:09.692	2.4%	2980989	0.047	0.688	5.271
history sync	00:00:00.013	0.0%	291	0.000	0.045	1.000
history write	01:51:17.999	7.7%	2887263	0.267	2.313	7.479
hiswrite/artcncl	00:00:00.017	0.0%	16	0.000	1.062	14.000
idle	15:07:04.065	63.0%	56421915	0.458	0.965	2.244
nntp read	00:43:44.751	3.0%	69564741	0.029	0.038	0.046
overview write	00:00:14.806	0.0%	2884900	0.003	0.005	0.007
perl filter	04:16:00.322	17.8%	2887263	2.646	5.320	7.368
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:21.978	0.4%	5785719	0.036	0.056	0.071
TOTAL: 24:00:02.928	23:35:20.859	98.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.099	0.0%	40233	0.000	0.002	0.015
article prepare	00:00:00.002	0.0%	6384	0.000	0.000	0.056
article read	00:00:46.193	0.1%	1636	0.000	28.235	302.250
backlog stats	00:00:00.097	0.0%	130942	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	34	0.000	0.000	0.000
data read	00:00:01.196	0.0%	69167	0.003	0.017	0.032
data write	00:00:03.488	0.0%	53742	0.018	0.065	0.197
idle	23:54:48.026	99.9%	130942	399.473	657.452	1335.377
status file	00:00:08.828	0.0%	8798	0.581	1.003	12.419
TOTAL: 23:55:58.755	23:55:47.929	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:29.717	73.7%	3013	0.000	9.863	10015.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.222	0.6%	6652	0.000	0.033	0.667
readart	00:00:00.016	0.0%	28	0.000	0.571	6.500
TOTAL: 00:00:40.321	00:00:29.955	74.3%	-	-	-	-

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
moderator@dana.de	0	0	0	2	0	0
TOTAL	0	0	0	2	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	599	2890519	2883820	4237	2462	99%	279:21:47
2	news.nask.pl	3	12269	6887	3043	2339	56%	23:48:15
3	news.icm.edu.pl	41	327	28	287	12	8%	17:09:22
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		645	2903116	2890736	7567	4813	99%	320:19:24

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	602.3 GB	20.7 MB	22.6 MB	602.3 GB	99%	218.8 KB
2	news.nask.pl	42.6 MB	424.1 KB	12.5 MB	55.5 MB	76%	6.2 KB
3	news.icm.edu.pl	539.7 KB	24.3 KB	155.5 KB	719.4 KB	75%	18.0 KB
4	localhost	1.7 KB	0.0 KB	0.0 KB	1.7 KB	100%	1.7 KB
TOTAL: 4		602.3 GB	21.2 MB	35.2 MB	602.4 GB	99%	218.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 11 04:15:02 - 04:59:59	99496	3.4%	36.88	23.6 GB	3.9%	9187.47
Mar 11 05:00:00 - 05:59:59	139671	4.8%	38.80	27.5 GB	4.6%	8012.45
Mar 11 06:00:00 - 06:59:59	136035	4.7%	37.79	32.6 GB	5.4%	9485.21
Mar 11 07:00:00 - 07:59:59	141519	4.9%	39.31	25.0 GB	4.2%	7282.52
Mar 11 08:00:00 - 08:59:59	98896	3.4%	27.47	22.6 GB	3.7%	6576.23
Mar 11 09:00:00 - 09:59:59	111191	3.8%	30.89	24.4 GB	4.1%	7119.74
Mar 11 10:00:00 - 10:59:59	114374	4.0%	31.77	21.1 GB	3.5%	6140.06
Mar 11 11:00:00 - 11:59:59	93153	3.2%	25.88	21.1 GB	3.5%	6143.79
Mar 11 12:00:00 - 12:59:59	76889	2.7%	21.36	22.4 GB	3.7%	6513.56
Mar 11 13:00:00 - 13:59:59	136551	4.7%	37.93	35.0 GB	5.8%	10192.94
Mar 11 14:00:00 - 14:59:59	120943	4.2%	33.60	30.7 GB	5.1%	8931.19
Mar 11 15:00:00 - 15:59:59	96094	3.3%	26.69	19.2 GB	3.2%	5606.59
Mar 11 16:00:00 - 16:59:59	132093	4.6%	36.69	28.9 GB	4.8%	8412.23
Mar 11 17:00:00 - 17:59:59	147877	5.1%	41.08	30.5 GB	5.1%	8886.12
Mar 11 18:00:00 - 18:59:59	162261	5.6%	45.07	27.5 GB	4.6%	8009.97
Mar 11 19:00:00 - 19:59:59	141257	4.9%	39.24	28.6 GB	4.7%	8321.10
Mar 11 20:00:00 - 20:59:59	138179	4.8%	38.38	29.8 GB	4.9%	8666.93
Mar 11 21:00:00 - 21:59:59	123093	4.3%	34.19	24.3 GB	4.0%	7070.24
Mar 11 22:00:00 - 22:59:59	93109	3.2%	25.86	17.7 GB	2.9%	5159.95
Mar 11 23:00:00 - 23:59:59	125281	4.3%	34.80	25.4 GB	4.2%	7405.21
Mar 12 00:00:00 - 00:59:59	78101	2.7%	21.69	15.4 GB	2.6%	4479.61
Mar 12 01:00:00 - 01:59:59	142902	4.9%	39.70	23.5 GB	3.9%	6833.00
Mar 12 02:00:00 - 02:59:59	112648	3.9%	31.29	21.5 GB	3.6%	6263.60
Mar 12 03:00:00 - 03:59:59	93142	3.2%	25.87	17.5 GB	2.9%	5106.28
Mar 12 04:00:00 - 04:15:03	35931	1.2%	39.79	6.7 GB	1.1%	7817.07
TOTAL: 24:00:01	2890686	100.0%	33.46	602.4 GB	100.0%	7310.95

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	2953	136	2292	0	525
2	news.nask.pl	2431	12	161	3	2255
3	news.icm.edu.pl	12	0	2	0	10
TOTAL: 3		5396	148	2455	3	2790

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	94
it.tlc.cellulari.android	23
comp.mobile.ipad	13
it.comp.os.win.windows10	10
nl.comp.sys.android	3
uk.rec.cycling.moderated	2
de.rec.sf.startrek	2
it.comp.os.win.windows7	1
TOTAL: 8	148

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2052
Binary in non-binary group	78
EMP (phl)	44
Scoring filter (8)	11
Scoring filter (9)	9
Scoring filter (11)	7
HTML post	5
Scoring filter (10)	4
Too many newsgroups	4
Scoring filter (18)	2
EMP (fsl)	1
TOTAL: 11	2217

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	491
	news.nask.pl	82
	TOTAL: 2	573
TOTAL: 1		573

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	24828	530	9516	135	87	30046	2%	23:59:58
2	poznan	10655	77	6858	6	0	0	0%	23:59:44
3	icm	22319	37	15473	331	0	0	0%	23:59:50
4	nask	6280	11	4075	0	0	0	0%	23:59:55
5	okapi	0	0	0	0	0	1150	0%	23:57:51
TOTAL: 5		64082	655	35922	472	87	31196	1%	119:57:18

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	6.0 MB	105.1 MB	111.0 MB	1.3 KB/s	308.9 KB	23:59:50
2	panorama	4.1 MB	501.4 KB	4.5 MB	0.1 KB/s	7.0 KB	23:59:58
3	poznan	278.4 KB	94.1 KB	372.5 KB	0.0 KB/s	4.5 KB	23:59:44
4	nask	90.6 KB	0.0 KB	90.6 KB	0.0 KB/s	8.2 KB	23:59:55
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:51
TOTAL: 5		10.4 MB	105.6 MB	116.0 MB	0.3 KB/s	105.4 KB	119:57:18

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	28	24.0 KB	13	0	00:00:24
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 2		289	28	24.0 KB	13	1	00:00:39

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	673	28	24.0 KB	13	1	00:00:29
2	unresolved	2	0	0.0 KB	0	0	00:00:10
TOTAL: 2		675	28	24.0 KB	13	1	00:00:39

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.544	6.148	00:00:24
185.48.193.99	0.012	0.028	00:00:10
mon.man.lodz.pl	1.292	5.872	00:00:03
david.man.lodz.pl	0.448	1.876	00:00:01
isvcs01.man.lodz.pl	0.004	0.040	00:00:00
TOTAL: 5	3.300	13.964	00:00:39

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.48.193.99	2
TOTAL: 3	386

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Mar 11 04:15:02 -- Mar 12 04:15:03