Daily Usenet report: Feb 2 04:15:03

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Feb 2 04:23:50 newsfeed overchan[30134]: input line too long, skipping
Feb 2 11:28:21 newsfeed nnrpd[14652]: SERVER perl filter not defined
Feb 2 14:08:36 newsfeed overchan[30134]: input line too long, skipping
Feb 2 16:46:13 newsfeed overchan[30134]: input line too long, skipping
Feb 2 16:49:39 newsfeed overchan[30134]: input line too long, skipping
Feb 2 17:09:54 newsfeed nnrpd[27374]: SERVER perl filter not defined
Feb 2 17:58:08 newsfeed overchan[30134]: input line too long, skipping
Feb 2 17:58:32 newsfeed overchan[30134]: input line too long, skipping
Feb 2 18:59:55 newsfeed overchan[30134]: input line too long, skipping
Feb 3 01:58:57 newsfeed overchan[30134]: input line too long, skipping
Feb 3 02:19:30 newsfeed overchan[30134]: input line too long, skipping
Feb 3 02:27:57 newsfeed overchan[30134]: input line too long, skipping
Feb 3 03:31:46 newsfeed overchan[30134]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3176576	97.8%	367.3 MB	97.5%
innfeed	44883	1.4%	5.3 MB	1.4%
innd	22851	0.7%	3.7 MB	1.0%
nnrpd	4788	0.1%	499.6 KB	0.1%
overchan	12	0.0%	2.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3249111	100.0%	376.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3153244	96.5%
Negative hits	102641	3.1%
Positive hits	10931	0.3%
Cache misses	410	0.0%
TOTAL: 4	3267226	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:10.767	0.0%	456	0.000	23.612	247.143
article cleanup	00:00:35.852	0.0%	3183045	0.008	0.011	0.016
article logging	00:02:11.707	0.2%	3183655	0.031	0.041	0.106
article parse	00:51:41.883	3.6%	76659832	0.024	0.040	0.060
article write	00:19:55.953	1.4%	3175643	0.227	0.377	0.763
artlog/artcncl	00:00:00.016	0.0%	454	0.000	0.035	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:17.187	0.2%	91100564	0.001	0.002	0.003
hisgrep/artcncl	00:00:03.134	0.0%	451	0.000	6.949	69.429
hishave/artcncl	00:00:00.563	0.0%	456	0.000	1.235	5.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:13:22.640	5.1%	3294565	0.372	1.336	6.125
history sync	00:00:00.019	0.0%	291	0.000	0.065	0.500
history write	04:02:08.909	16.8%	3179364	1.556	4.570	9.153
hiswrite/artcncl	00:00:00.191	0.0%	5	0.000	38.200	183.000
idle	10:42:20.662	44.6%	51292738	0.197	0.751	3.001
nntp read	00:54:02.691	3.8%	74332563	0.034	0.044	0.054
overview write	00:00:17.250	0.0%	3175643	0.004	0.005	0.007
perl filter	05:13:43.285	21.8%	3179364	3.540	5.920	7.761
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:58.930	0.4%	6371677	0.036	0.056	0.077
TOTAL: 24:00:06.732	23:28:51.639	97.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.179	0.0%	58957	0.000	0.003	0.012
article prepare	00:00:00.001	0.0%	9462	0.000	0.000	0.004
article read	00:01:08.329	0.1%	2403	0.000	28.435	298.429
backlog stats	00:00:00.147	0.0%	165782	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	49	0.000	0.000	0.000
data read	00:00:01.544	0.0%	88242	0.005	0.017	0.035
data write	00:00:04.097	0.0%	68417	0.025	0.060	0.144
idle	23:51:55.266	99.9%	165782	334.944	518.242	898.430
status file	00:00:33.255	0.0%	15749	0.733	2.112	38.350
TOTAL: 23:53:53.818	23:53:42.818	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	20:50:36.272	99.9%	748357	0.000	100.268	164.778
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:49.912	0.1%	1497426	0.000	0.033	2.500
readart	00:00:00.006	0.0%	72	0.000	0.083	0.500
TOTAL: 20:52:23.625	20:51:26.190	99.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	673	3167547	3157614	5929	4004	99%	485:55:18
2	news.nask.pl	3	14741	10058	1117	3566	68%	24:11:50
3	news.icm.edu.pl	44	272	11	222	39	4%	15:50:21
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		723	3182562	3167685	7268	7609	99%	525:57:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	707.2 GB	24.2 MB	59.9 MB	707.3 GB	99%	234.6 KB
2	news.nask.pl	45.5 MB	542.7 KB	20.4 MB	66.4 MB	68%	5.0 KB
3	news.icm.edu.pl	236.6 KB	69.0 KB	2.8 MB	3.1 MB	7%	63.3 KB
4	localhost	2.8 KB	0.0 KB	0.0 KB	2.8 KB	100%	1.4 KB
TOTAL: 4		707.3 GB	24.8 MB	83.1 MB	707.4 GB	99%	233.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 2 04:15:03 - 04:59:59	131221	4.1%	48.65	25.1 GB	3.6%	9760.00
Feb 2 05:00:00 - 05:59:59	178443	5.6%	49.57	34.9 GB	4.9%	10152.78
Feb 2 06:00:00 - 06:59:59	176319	5.6%	48.98	34.0 GB	4.8%	9905.61
Feb 2 07:00:00 - 07:59:59	181239	5.7%	50.34	34.8 GB	4.9%	10146.78
Feb 2 08:00:00 - 08:59:59	144709	4.6%	40.20	23.3 GB	3.3%	6800.40
Feb 2 09:00:00 - 09:59:59	172350	5.4%	47.88	31.5 GB	4.5%	9189.22
Feb 2 10:00:00 - 10:59:59	179418	5.7%	49.84	37.2 GB	5.3%	10833.11
Feb 2 11:00:00 - 11:59:59	102297	3.2%	28.42	28.9 GB	4.1%	8413.83
Feb 2 12:00:00 - 12:59:59	123425	3.9%	34.28	27.5 GB	3.9%	8003.85
Feb 2 13:00:00 - 13:59:59	77372	2.4%	21.49	18.3 GB	2.6%	5332.66
Feb 2 14:00:00 - 14:59:59	80484	2.5%	22.36	21.6 GB	3.1%	6283.22
Feb 2 15:00:00 - 15:59:59	112581	3.6%	31.27	22.4 GB	3.2%	6538.27
Feb 2 16:00:00 - 16:59:59	89516	2.8%	24.87	20.6 GB	2.9%	6004.68
Feb 2 17:00:00 - 17:59:59	135636	4.3%	37.68	38.3 GB	5.4%	11154.96
Feb 2 18:00:00 - 18:59:59	150537	4.8%	41.82	36.4 GB	5.1%	10590.45
Feb 2 19:00:00 - 19:59:59	103163	3.3%	28.66	27.4 GB	3.9%	7988.53
Feb 2 20:00:00 - 20:59:59	142796	4.5%	39.67	36.6 GB	5.2%	10652.59
Feb 2 21:00:00 - 21:59:59	117067	3.7%	32.52	28.5 GB	4.0%	8307.09
Feb 2 22:00:00 - 22:59:59	154845	4.9%	43.01	35.7 GB	5.0%	10397.17
Feb 2 23:00:00 - 23:59:59	134292	4.2%	37.30	33.6 GB	4.7%	9774.66
Feb 3 00:00:00 - 00:59:59	101670	3.2%	28.24	23.8 GB	3.4%	6937.62
Feb 3 01:00:00 - 01:59:59	115799	3.7%	32.17	28.6 GB	4.0%	8330.41
Feb 3 02:00:00 - 02:59:59	129200	4.1%	35.89	28.6 GB	4.0%	8334.03
Feb 3 03:00:00 - 03:59:59	110936	3.5%	30.82	23.9 GB	3.4%	6955.35
Feb 3 04:00:00 - 04:15:03	22597	0.7%	25.02	5.5 GB	0.8%	6423.89
TOTAL: 24:00:00	3167912	100.0%	36.67	707.1 GB	100.0%	8581.27

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4444	234	3470	2	738
2	news.nask.pl	3727	33	182	7	3505
3	news.icm.edu.pl	39	0	2	0	37
TOTAL: 3		8210	267	3654	9	4280

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	145
it.tlc.cellulari.android	44
it.comp.os.win.windows10	36
comp.mobile.ipad	17
comp.sys.raspberry-pi	8
de.rec.sf.startrek	6
it.comp.os.win.windows7	3
alt.sex.telephones	2
it.comp.os.linux.ubuntu	2
comp.mobile.android	1
de.comp.lang.vbclassic	1
it.discussioni.energia	1
de.comm.software.mailreader	1
TOTAL: 13	267

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

Groups	Count
pl.praca.oferowana	8
bit.listserv.catholic	1
TOTAL: 2	9

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3175
Binary in non-binary group	420
Scoring filter (9)	21
Scoring filter (8)	19
Scoring filter (10)	10
EMP (phl)	8
Scoring filter (18)	6
HTML post	4
Scoring filter (11)	3
Too many newsgroups	2
Attached HTML file	1
Scoring filter (12)	1
Scoring filter (17)	1
Scoring filter (16)	1
Scoring filter (14)	1
TOTAL: 15	3673

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	426
	news.nask.pl	181
	TOTAL: 2	607
TOTAL: 1		607

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	44033	965	16440	288	112	41406	2%	23:59:58
2	poznan	16119	206	9692	27	0	0	1%	23:59:11
3	icm	24397	37	18956	78	0	0	0%	23:59:58
4	nask	2954	7	2359	0	0	0	0%	23:57:31
5	okapi	0	0	0	0	0	1152	0%	23:57:51
TOTAL: 5		87503	1215	47447	393	112	42558	1%	119:54:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	5.7 MB	25.8 MB	31.5 MB	0.4 KB/s	280.6 KB	23:59:58
2	panorama	3.5 MB	1.8 MB	5.3 MB	0.1 KB/s	4.3 KB	23:59:58
3	poznan	847.8 KB	146.3 KB	994.2 KB	0.0 KB/s	4.3 KB	23:59:11
4	nask	13.7 KB	0.0 KB	13.7 KB	0.0 KB/s	2.0 KB	23:57:31
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:51
TOTAL: 5		10.1 MB	27.7 MB	37.8 MB	0.1 KB/s	24.1 KB	119:54:29

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	72	60.8 KB	34	0	00:00:31
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 2		290	72	60.8 KB	34	2	20:52:22

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	674	72	60.8 KB	34	2	0	00:00:36
TOTAL: 1		674	72	60.8 KB	34	2	0	20:52:22

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89.38.41.35	45.832	79.588	20:51:46
web.man.lodz.pl	1.732	7.556	00:00:31
mon.man.lodz.pl	1.464	7.024	00:00:03
david.man.lodz.pl	0.396	2.324	00:00:01
isvcs01.man.lodz.pl	0.024	0.060	00:00:00
TOTAL: 5	49.448	96.552	20:52:22

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	60
2	pl.comp.pecet	12
TOTAL: 2		72

Daily Usenet report

Feb 2 04:15:03 -- Feb 3 04:15:03