Daily Usenet report: Aug 14 04:15:02

Unknown entries from news log file:

First 50 / 55 lines (90.9%)

Aug 14 08:28:02 newsfeed overchan[25908]: input line too long, skipping
Aug 14 09:07:44 newsfeed overchan[25908]: input line too long, skipping
Aug 14 11:00:20 newsfeed overchan[25908]: input line too long, skipping
Aug 14 11:09:06 newsfeed overchan[25908]: input line too long, skipping
Aug 14 12:07:13 newsfeed nnrpd[320]: SERVER perl filter not defined
Aug 14 12:15:50 newsfeed overchan[25908]: input line too long, skipping
Aug 14 12:16:49 newsfeed overchan[25908]: input line too long, skipping
Aug 14 12:30:40 newsfeed nnrpd[3936]: SERVER perl filter not defined
Aug 14 13:26:56 newsfeed overchan[25908]: input line too long, skipping
Aug 14 14:00:06 newsfeed overchan[25908]: input line too long, skipping
Aug 14 14:08:34 newsfeed overchan[25908]: input line too long, skipping
Aug 14 14:11:08 newsfeed overchan[25908]: input line too long, skipping
Aug 14 14:24:36 newsfeed overchan[25908]: input line too long, skipping
Aug 14 14:35:51 newsfeed overchan[25908]: input line too long, skipping
Aug 14 14:43:30 newsfeed overchan[25908]: input line too long, skipping
Aug 14 14:44:32 newsfeed overchan[25908]: input line too long, skipping
Aug 14 14:49:31 newsfeed nnrpd[23917]: SERVER perl filter not defined
Aug 14 14:53:45 newsfeed overchan[25908]: input line too long, skipping
Aug 14 15:09:54 newsfeed overchan[25908]: input line too long, skipping
Aug 14 15:34:08 newsfeed nnrpd[30499]: SERVER perl filter not defined
Aug 14 15:42:12 newsfeed overchan[25908]: input line too long, skipping
Aug 14 15:52:11 newsfeed overchan[25908]: input line too long, skipping
Aug 14 15:54:28 newsfeed overchan[25908]: input line too long, skipping
Aug 14 16:32:42 newsfeed overchan[25908]: input line too long, skipping
Aug 14 20:34:57 newsfeed overchan[25908]: input line too long, skipping
Aug 14 20:36:59 newsfeed overchan[25908]: input line too long, skipping
Aug 14 21:22:26 newsfeed overchan[25908]: input line too long, skipping
Aug 14 21:51:06 newsfeed overchan[25908]: input line too long, skipping
Aug 14 22:03:32 newsfeed overchan[25908]: input line too long, skipping
Aug 14 22:12:19 newsfeed overchan[25908]: input line too long, skipping
Aug 14 22:14:11 newsfeed overchan[25908]: input line too long, skipping
Aug 14 22:19:07 newsfeed overchan[25908]: input line too long, skipping
Aug 14 22:27:21 newsfeed overchan[25908]: input line too long, skipping
Aug 14 22:30:37 newsfeed overchan[25908]: input line too long, skipping
Aug 14 22:30:50 newsfeed overchan[25908]: input line too long, skipping
Aug 14 22:40:36 newsfeed overchan[25908]: input line too long, skipping
Aug 14 22:46:27 newsfeed overchan[25908]: input line too long, skipping
Aug 14 23:05:10 newsfeed overchan[25908]: input line too long, skipping
Aug 14 23:09:14 newsfeed overchan[25908]: input line too long, skipping
Aug 14 23:14:47 newsfeed overchan[25908]: input line too long, skipping
Aug 14 23:29:51 newsfeed overchan[25908]: input line too long, skipping
Aug 14 23:38:32 newsfeed overchan[25908]: input line too long, skipping
Aug 14 23:49:00 newsfeed overchan[25908]: input line too long, skipping
Aug 14 23:53:21 newsfeed overchan[25908]: input line too long, skipping
Aug 15 00:03:50 newsfeed overchan[25908]: input line too long, skipping
Aug 15 00:09:40 newsfeed overchan[25908]: input line too long, skipping
Aug 15 00:22:21 newsfeed overchan[25908]: input line too long, skipping
Aug 15 00:42:14 newsfeed overchan[25908]: input line too long, skipping
Aug 15 01:57:56 newsfeed overchan[25908]: input line too long, skipping
Aug 15 03:09:54 newsfeed overchan[25908]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	646538	93.6%	71.3 MB	92.9%
innfeed	29678	4.3%	3.5 MB	4.6%
innd	9294	1.3%	1.4 MB	1.8%
nnrpd	5010	0.7%	526.7 KB	0.7%
overchan	52	0.0%	9.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	690573	100.0%	76.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	641126	99.5%
Negative hits	2831	0.4%
Positive hits	360	0.1%
Cache misses	35	0.0%
TOTAL: 4	644352	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.195	0.0%	128	0.000	32.773	368.000
article cleanup	00:00:10.191	0.0%	645567	0.010	0.016	0.023
article logging	00:00:37.573	0.0%	646080	0.048	0.058	0.072
article parse	00:20:26.719	1.4%	34463168	0.023	0.036	0.044
article write	00:09:13.791	0.6%	645031	0.596	0.859	1.105
artlog/artcncl	00:00:00.005	0.0%	128	0.000	0.039	1.000
data move	00:00:39.248	0.0%	38901423	0.001	0.001	0.001
hisgrep/artcncl	00:00:00.520	0.0%	125	0.000	4.160	35.000
hishave/artcncl	00:00:00.308	0.0%	128	0.000	2.406	19.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:36:07.047	6.7%	648784	6.763	8.889	15.362
history sync	00:00:00.030	0.0%	291	0.000	0.103	1.000
history write	01:46:24.164	7.4%	645514	8.089	9.890	17.193
hiswrite/artcncl	00:00:00.029	0.0%	3	6.000	9.667	11.500
idle	18:05:58.675	75.4%	33576157	1.341	1.941	3.930
nntp read	00:30:15.381	2.1%	34094155	0.041	0.053	0.061
overview write	00:00:03.650	0.0%	645031	0.002	0.006	0.010
perl filter	01:16:05.075	5.3%	645514	5.193	7.072	8.574
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:42.128	0.0%	1303816	0.027	0.032	0.037
TOTAL: 24:00:04.691	23:46:48.729	99.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.119	0.0%	51437	0.000	0.002	0.014
article prepare	00:00:00.003	0.0%	8640	0.000	0.000	0.000
article read	00:00:20.498	0.0%	2162	0.000	9.481	80.500
backlog stats	00:00:00.083	0.0%	101140	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:01.124	0.0%	52467	0.005	0.021	0.054
data write	00:00:02.316	0.0%	38864	0.023	0.060	0.117
idle	23:54:27.950	99.9%	101140	32.027	850.978	1650.559
status file	00:01:08.075	0.1%	9750	0.967	6.982	100.607
TOTAL: 23:56:05.146	23:56:00.168	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:02:02.089	86.8%	3164	0.000	38.587	859.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.261	0.2%	6932	0.000	0.038	0.667
readart	00:00:00.093	0.1%	16	0.000	5.812	14.500
TOTAL: 00:02:20.588	00:02:02.443	87.1%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	193

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	221	645807	645325	0	482	99%	90:42:52
2	news.icm.edu.pl	45	310	41	221	48	13%	16:57:55
3	localhost	1434	4	4	0	0	100%	00:00:00
TOTAL: 3		1700	646121	645370	221	530	99%	107:40:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	289.0 GB	2.4 MB	3.6 MB	289.0 GB	99%	469.3 KB
2	news.icm.edu.pl	2.1 MB	302.8 KB	1.5 MB	3.9 MB	53%	45.2 KB
3	localhost	5.1 KB	0.0 KB	0.0 KB	5.1 KB	100%	1.3 KB
TOTAL: 3		289.0 GB	2.7 MB	5.1 MB	289.0 GB	99%	469.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 14 04:15:02 - 04:59:59	18957	2.9%	7.03	7.8 GB	2.7%	3029.29
Aug 14 05:00:00 - 05:59:59	23661	3.7%	6.57	10.5 GB	3.6%	3055.00
Aug 14 06:00:00 - 06:59:59	25098	3.9%	6.97	11.5 GB	4.0%	3339.64
Aug 14 07:00:00 - 07:59:59	24563	3.8%	6.82	11.5 GB	4.0%	3356.99
Aug 14 08:00:00 - 08:59:59	24963	3.9%	6.93	11.5 GB	4.0%	3336.06
Aug 14 09:00:00 - 09:59:59	26039	4.0%	7.23	11.5 GB	4.0%	3363.42
Aug 14 10:00:00 - 10:59:59	29295	4.5%	8.14	12.3 GB	4.2%	3571.22
Aug 14 11:00:00 - 11:59:59	27242	4.2%	7.57	11.6 GB	4.0%	3386.03
Aug 14 12:00:00 - 12:59:59	31293	4.8%	8.69	13.7 GB	4.7%	3988.65
Aug 14 13:00:00 - 13:59:59	27037	4.2%	7.51	12.6 GB	4.3%	3666.57
Aug 14 14:00:00 - 14:59:59	28736	4.5%	7.98	13.1 GB	4.5%	3827.99
Aug 14 15:00:00 - 15:59:59	29671	4.6%	8.24	13.4 GB	4.6%	3898.87
Aug 14 16:00:00 - 16:59:59	29858	4.6%	8.29	13.5 GB	4.7%	3938.65
Aug 14 17:00:00 - 17:59:59	30707	4.8%	8.53	14.0 GB	4.8%	4074.49
Aug 14 18:00:00 - 18:59:59	27267	4.2%	7.57	12.6 GB	4.4%	3682.13
Aug 14 19:00:00 - 19:59:59	24984	3.9%	6.94	11.0 GB	3.8%	3215.68
Aug 14 20:00:00 - 20:59:59	26742	4.1%	7.43	11.8 GB	4.1%	3430.74
Aug 14 21:00:00 - 21:59:59	26160	4.1%	7.27	11.9 GB	4.1%	3478.72
Aug 14 22:00:00 - 22:59:59	24577	3.8%	6.83	12.0 GB	4.1%	3480.96
Aug 14 23:00:00 - 23:59:59	27287	4.2%	7.58	11.6 GB	4.0%	3380.23
Aug 15 00:00:00 - 00:59:59	25943	4.0%	7.21	12.3 GB	4.3%	3595.70
Aug 15 01:00:00 - 01:59:59	24392	3.8%	6.78	12.8 GB	4.4%	3741.87
Aug 15 02:00:00 - 02:59:59	27580	4.3%	7.66	11.5 GB	4.0%	3354.75
Aug 15 03:00:00 - 03:59:59	26707	4.1%	7.42	10.9 GB	3.8%	3172.05
Aug 15 04:00:00 - 04:15:02	6600	1.0%	7.32	2.8 GB	1.0%	3263.44
TOTAL: 24:00:00	645359	100.0%	7.47	289.8 GB	100.0%	3517.68

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	997	440	39	3	515
2	news.icm.edu.pl	54	0	14	0	40
TOTAL: 2		1051	440	53	3	555

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	372
it.tlc.cellulari.android	21
comp.sys.raspberry-pi	17
comp.mobile.android	15
it.comp.os.win.windows10	10
comp.sys.mac.vintage	3
de.rec.sf.startrek	1
nl.comp.os.linux.techniek	1
TOTAL: 8	440

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

Groups	Count
pl.praca.oferowana	3
TOTAL: 1	3

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	26
Scoring filter (8)	9
Binary in non-binary group	3
Scoring filter (10)	1
Too many newsgroups	1
TOTAL: 5	40

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	515
	TOTAL: 1	515
TOTAL: 1		515

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	38036	493	20269	1290	4	29449	1%	23:59:57
2	icm	16161	235	13276	13	0	0	1%	23:59:57
3	poznan	26	1	21	0	0	0	3%	02:54:44
4	nask	0	0	0	0	0	9744	0%	23:57:46
5	okapi	0	0	0	0	0	755	0%	23:57:46
TOTAL: 5		54223	729	33566	1303	4	39948	1%	98:50:10

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	1.4 MB	5.3 MB	6.7 MB	0.1 KB/s	3.9 KB	23:59:57
2	icm	750.0 KB	81.2 KB	831.2 KB	0.0 KB/s	3.4 KB	23:59:57
3	poznan	11.3 KB	0.0 KB	11.3 KB	0.0 KB/s	11.3 KB	02:54:44
4	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
TOTAL: 5		2.1 MB	5.4 MB	7.5 MB	0.0 KB/s	3.8 KB	98:50:10

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	8	7.6 KB	4	0	00:00:19
2	ip-79-111-222-6.bb.netbynet.ru	12	4	5.1 KB	3	0	00:01:46
3	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:01
TOTAL: 3		304	12	12.7 KB	7	4	00:02:20

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	580	8	7.6 KB	4	4	00:00:27
2	*.bb.netbynet.ru	12	4	5.1 KB	3	0	00:01:46
3	unresolved	100	0	0.0 KB	0	0	00:00:06
TOTAL: 3		692	12	12.7 KB	7	4	00:02:20

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
ip-79-111-222-6.bb.netbynet.ru	0.076	0.151	00:01:46
web.man.lodz.pl	1.765	3.566	00:00:19
mon.man.lodz.pl	1.630	3.309	00:00:06
80.111.142.213	0.023	0.049	00:00:05
212.51.192.185	0.508	1.061	00:00:01
isvcs01.man.lodz.pl	0.048	0.071	00:00:01
TOTAL: 6	4.050	8.207	00:02:20

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
212.51.192.185	96
80.111.142.213	4
TOTAL: 3	388

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	8	66.7%
2	lodman	4	33.3%
TOTAL: 2		12	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	4
2	pl.comp.os.ms-windows.winnt	4
3	lodman.info	4
TOTAL: 3		12

Daily Usenet report

Aug 14 04:15:02 -- Aug 15 04:15:02