Daily Usenet report: Feb 23 04:15:01

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Feb 23 05:53:03 newsfeed overchan[2610]: input line too long, skipping
Feb 23 09:21:54 newsfeed nnrpd[27033]: SERVER perl filter not defined
Feb 23 13:19:02 newsfeed nnrpd[2755]: SERVER perl filter not defined
Feb 23 14:31:18 newsfeed nnrpd[5415]: SERVER perl filter not defined
Feb 23 14:33:40 newsfeed nnrpd[5428]: SERVER perl filter not defined
Feb 23 14:34:10 newsfeed nnrpd[5429]: SERVER perl filter not defined
Feb 23 14:34:38 newsfeed nnrpd[5437]: SERVER perl filter not defined
Feb 23 14:35:11 newsfeed nnrpd[5505]: SERVER perl filter not defined
Feb 23 15:30:31 newsfeed nnrpd[7465]: SERVER perl filter not defined
Feb 23 22:18:29 newsfeed nnrpd[21469]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3359796	98.6%	387.2 MB	98.3%
innd	37708	1.1%	5.4 MB	1.4%
innfeed	4847	0.1%	684.9 KB	0.2%
nnrpd	4830	0.1%	495.4 KB	0.1%
overchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	3407182	100.0%	393.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3351493	97.0%
Negative hits	89575	2.6%
Positive hits	14424	0.4%
Cache misses	117	0.0%
TOTAL: 4	3455609	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.522	0.0%	259	0.000	17.459	3225.000
article cleanup	00:00:49.797	0.1%	3359053	0.007	0.015	0.026
article logging	00:01:55.335	0.1%	3360287	0.017	0.034	0.703
article parse	01:29:26.541	6.2%	200434812	0.016	0.027	0.078
article write	00:39:27.646	2.7%	3340818	0.309	0.709	2.201
artlog/artcncl	00:00:00.003	0.0%	226	0.000	0.013	1.000
artlog/artparse	00:00:00.001	0.0%	30	0.000	0.033	1.000
data move	00:03:55.146	0.3%	220569326	0.001	0.001	0.007
hisgrep/artcncl	00:00:00.392	0.0%	232	0.000	1.690	44.000
hishave/artcncl	00:00:00.084	0.0%	259	0.000	0.324	4.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:31:41.192	2.2%	3456988	0.124	0.550	8.011
history sync	00:00:00.015	0.0%	292	0.000	0.051	1.000
history write	00:48:15.536	3.4%	3352953	0.202	0.864	9.007
hiswrite/artcncl	00:00:00.006	0.0%	27	0.000	0.222	1.000
idle	11:34:57.531	48.2%	129209965	0.143	0.323	1.037
nntp read	01:17:40.675	5.4%	197736427	0.016	0.024	0.044
overview write	00:00:19.130	0.0%	3340818	0.001	0.006	0.011
perl filter	06:54:16.827	28.8%	3352923	5.837	7.413	9.533
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:47.931	0.4%	6722216	0.034	0.052	0.091
TOTAL: 24:00:22.876	23:28:38.310	97.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.230	0.0%	70053	0.000	0.003	0.105
article prepare	00:00:00.017	0.0%	50036	0.000	0.000	0.050
article read	00:00:56.041	0.1%	12513	0.000	4.479	334.875
backlog stats	00:00:00.250	0.0%	236814	0.000	0.001	0.025
callbacks	00:00:00.000	0.0%	6	0.000	0.000	0.000
data read	00:00:01.908	0.0%	129057	0.000	0.015	0.266
data write	00:00:09.831	0.0%	105417	0.000	0.093	1.196
idle	23:58:09.616	99.9%	236814	19.146	364.377	1749.390
status file	00:00:00.693	0.0%	860	0.000	0.806	4.000
TOTAL: 23:59:25.240	23:59:18.586	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:16.992	56.4%	3108	0.000	5.467	27.455
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.239	0.8%	6866	0.000	0.035	2.263
readart	00:00:00.004	0.0%	62	0.000	0.065	0.500
TOTAL: 00:00:30.134	00:00:17.235	57.2%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	189

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1438	3339980	3329769	4006	6205	99%	434:06:34
2	news.nask.pl	2	26681	10557	4028	12096	39%	24:03:41
3	news.icm.edu.pl	41	242	24	207	11	9%	14:59:23
4	localhost	10	9	9	0	0	100%	00:00:00
TOTAL: 4		1491	3366912	3340359	8241	18312	99%	473:09:38

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	979.9 GB	91.2 MB	174.2 MB	980.2 GB	99%	308.1 KB
2	news.nask.pl	61.8 MB	1.5 MB	200.2 MB	263.6 MB	23%	11.9 KB
3	news.icm.edu.pl	571.1 KB	40.8 KB	252.8 KB	864.7 KB	66%	24.7 KB
4	localhost	14.1 KB	0.0 KB	0.0 KB	14.1 KB	100%	1.6 KB
TOTAL: 4		980.0 GB	92.7 MB	374.7 MB	980.5 GB	99%	306.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 23 04:15:01 - 04:59:59	108360	3.2%	40.15	31.8 GB	3.2%	12346.51
Feb 23 05:00:00 - 05:59:59	147397	4.4%	40.94	42.7 GB	4.4%	12430.89
Feb 23 06:00:00 - 06:59:59	146963	4.4%	40.82	42.8 GB	4.4%	12475.56
Feb 23 07:00:00 - 07:59:59	149099	4.5%	41.42	43.1 GB	4.4%	12556.01
Feb 23 08:00:00 - 08:59:59	122429	3.7%	34.01	35.4 GB	3.6%	10309.07
Feb 23 09:00:00 - 09:59:59	146022	4.4%	40.56	42.7 GB	4.4%	12451.84
Feb 23 10:00:00 - 10:59:59	142528	4.3%	39.59	41.9 GB	4.3%	12193.55
Feb 23 11:00:00 - 11:59:59	142739	4.3%	39.65	40.7 GB	4.2%	11865.13
Feb 23 12:00:00 - 12:59:59	144446	4.3%	40.12	42.8 GB	4.4%	12457.01
Feb 23 13:00:00 - 13:59:59	142916	4.3%	39.70	42.1 GB	4.3%	12255.45
Feb 23 14:00:00 - 14:59:59	132378	4.0%	36.77	38.4 GB	3.9%	11198.93
Feb 23 15:00:00 - 15:59:59	129700	3.9%	36.03	38.9 GB	4.0%	11320.79
Feb 23 16:00:00 - 16:59:59	126020	3.8%	35.01	40.7 GB	4.2%	11857.61
Feb 23 17:00:00 - 17:59:59	127420	3.8%	35.39	40.0 GB	4.1%	11637.13
Feb 23 18:00:00 - 18:59:59	127683	3.8%	35.47	41.3 GB	4.2%	12024.02
Feb 23 19:00:00 - 19:59:59	130732	3.9%	36.31	40.7 GB	4.2%	11857.03
Feb 23 20:00:00 - 20:59:59	155251	4.6%	43.13	39.9 GB	4.1%	11627.74
Feb 23 21:00:00 - 21:59:59	137807	4.1%	38.28	41.1 GB	4.2%	11965.76
Feb 23 22:00:00 - 22:59:59	147279	4.4%	40.91	42.4 GB	4.3%	12343.88
Feb 23 23:00:00 - 23:59:59	148998	4.5%	41.39	41.9 GB	4.3%	12202.01
Feb 24 00:00:00 - 00:59:59	116471	3.5%	32.35	33.6 GB	3.4%	9778.23
Feb 24 01:00:00 - 01:59:59	150403	4.5%	41.78	43.1 GB	4.4%	12544.53
Feb 24 02:00:00 - 02:59:59	150678	4.5%	41.85	43.2 GB	4.4%	12586.18
Feb 24 03:00:00 - 03:59:59	132088	4.0%	36.69	37.3 GB	3.8%	10858.89
Feb 24 04:00:00 - 04:15:02	34264	1.0%	37.99	9.8 GB	1.0%	11353.22
TOTAL: 24:00:01	3340071	100.0%	38.66	978.1 GB	100.0%	11870.62

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	12297	68	473	4	11752
2	newsfeed.pionier.net.pl	7194	140	5656	0	1398
3	news.icm.edu.pl	8	0	1	0	7
TOTAL: 3		19499	208	6130	4	13157

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	58
comp.mobile.android	52
it.comp.os.win.windows10	34
it.tlc.cellulari.android	31
comp.mobile.ipad	11
comp.sys.mac.vintage	6
alt.sex.telephones	6
uk.rec.cycling.moderated	4
comp.sys.raspberry-pi	4
it.comp.virtualizzazione	1
de.rec.sf.startrek	1
TOTAL: 11	208

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	10524
Binary in non-binary group	1035
Scoring filter (8)	95
Poison newsgroup	84
Scoring filter (9)	58
EMP (phl)	28
Scoring filter (10)	22
EMP (fsl)	16
Scoring filter (12)	8
Scoring filter (11)	7
Scoring filter (17)	5
Too many newsgroups	4
Scoring filter (15)	3
HTML post	2
Scoring filter (16)	1
Scoring filter (13)	1
TOTAL: 16	11893

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	29774	1348	26568	505	16	41377	4%	23:58:18
2	poznan	16162	346	10125	32	0	0	2%	24:00:03
3	nask	7958	115	5175	3	0	0	1%	23:52:43
4	icm	38867	55	23165	9942	0	0	0%	23:55:31
5	okapi	0	0	0	0	0	1788	0%	24:00:00
TOTAL: 5		92761	1864	65033	10482	16	43165	2%	119:46:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	6.6 MB	2.2 MB	8.8 MB	0.1 KB/s	4.9 KB	23:58:18
2	poznan	1.5 MB	375.6 KB	1.8 MB	0.0 KB/s	5.0 KB	24:00:03
3	icm	905.9 KB	2.2 GB	2.2 GB	27.3 KB/s	234.8 KB	23:55:31
4	nask	391.9 KB	8.1 KB	400.0 KB	0.0 KB/s	3.4 KB	23:52:43
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		9.3 MB	2.2 GB	2.2 GB	5.5 KB/s	191.0 KB	119:46:35

Backlog files shrunk by innfeed:

Server	Size
panorama	976.8 KB
TOTAL: 1	976.8 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	62	66.7 KB	27	0	00:00:23
2	isvcs01.man.lodz.pl	9	0	0.0 KB	0	9	00:00:00
TOTAL: 2		297	62	66.7 KB	27	9	00:00:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	681	62	66.7 KB	27	9	0	00:00:29
TOTAL: 1		681	62	66.7 KB	27	9	0	00:00:29

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.090	4.524	00:00:23
mon.man.lodz.pl	0.929	3.673	00:00:04
david.man.lodz.pl	0.291	1.227	00:00:01
isvcs01.man.lodz.pl	0.046	0.137	00:00:00
TOTAL: 4	2.356	9.561	00:00:29

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	48
2	pl.comp.pecet	14
TOTAL: 2		62

Daily Usenet report

Feb 23 04:15:01 -- Feb 24 04:15:02