Daily Usenet report

Dec 30 04:15:02 -- Dec 31 04:15:02

Log entries by program
History cache
INND timer
INNfeed timer
nnrpd timer
Control commands to INND
Incoming Feeds (INN)
Incoming Volume (INN)
Incoming articles
Sites sending bad articles
Unwanted newsgroups
Supposedly-moderated groups with unmoderated postings
INND Perl filter
Outgoing Feeds (innfeed) by Articles
Outgoing Feeds (innfeed) by Volume
Backlog files shrunk by innfeed
NNRP readership statistics
NNRP readership statistics (by domain)
NNRP total resource statistics
Curious NNRP server explorers
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Dec 30 09:05:11 newsfeed nnrpd[17918]: SERVER perl filter not defined
Dec 30 09:28:49 newsfeed nnrpd[18628]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3329473	98.7%	388.1 MB	98.5%
innd	32893	1.0%	4.8 MB	1.2%
innfeed	5042	0.1%	721.0 KB	0.2%
nnrpd	4757	0.1%	492.7 KB	0.1%
TOTAL: 4	3372165	100.0%	394.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3323440	96.8%
Negative hits	98018	2.9%
Positive hits	13474	0.4%
Cache misses	104	0.0%
TOTAL: 4	3435036	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.263	0.0%	194	0.000	16.820	755.000
article cleanup	00:00:48.685	0.1%	3327983	0.005	0.015	0.032
article logging	00:02:02.855	0.1%	3328653	0.018	0.037	1.100
article parse	01:16:43.145	5.3%	175413021	0.011	0.026	0.040
article write	01:17:13.552	5.4%	3312192	0.284	1.399	5.305
artlog/artcncl	00:00:00.003	0.0%	188	0.000	0.016	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:03:36.897	0.3%	194446696	0.001	0.001	0.003
hisgrep/artcncl	00:00:00.544	0.0%	176	0.000	3.091	154.500
hishave/artcncl	00:00:00.070	0.0%	194	0.000	0.361	48.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:31:02.582	2.2%	3435693	0.093	0.542	11.641
history sync	00:00:00.016	0.0%	292	0.000	0.055	1.000
history write	00:42:38.470	3.0%	3324119	0.212	0.770	11.305
hiswrite/artcncl	00:00:00.028	0.0%	18	0.000	1.556	13.000
idle	12:06:12.279	50.4%	105465719	0.287	0.413	1.190
nntp read	00:59:01.668	4.1%	172522639	0.014	0.021	0.032
overview write	00:00:21.163	0.0%	3312192	0.001	0.006	0.013
perl filter	06:12:22.285	25.9%	3324118	4.695	6.721	9.540
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:06:19.382	0.4%	6939826	0.034	0.055	0.091
TOTAL: 23:59:35.412	23:18:26.887	97.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:01.376	0.0%	334221	0.000	0.004	0.250
article prepare	00:00:00.302	0.0%	1199218	0.000	0.000	0.028
article read	00:00:59.315	0.1%	300279	0.000	0.198	351.714
backlog stats	00:00:01.472	0.0%	1648673	0.000	0.001	0.037
callbacks	00:00:00.005	0.0%	554	0.000	0.009	0.333
data read	00:00:08.913	0.0%	679445	0.000	0.013	0.120
data write	00:02:10.796	0.2%	1001037	0.000	0.131	0.240
idle	23:55:20.967	99.7%	1648673	10.932	52.237	4679.000
status file	00:00:00.925	0.0%	1256	0.000	0.736	5.000
TOTAL: 23:59:25.194	23:58:44.071	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:15.956	58.4%	3030	0.000	5.266	26.889
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.154	0.6%	6679	0.000	0.023	0.667
readart	00:00:00.001	0.0%	28	0.000	0.036	0.500
TOTAL: 00:00:27.321	00:00:16.111	59.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	304	3312783	3302406	6598	3779	99%	357:24:29
2	news.nask.pl	2	25119	10434	2649	12036	41%	23:59:01
3	news.icm.edu.pl	43	303	13	286	4	4%	16:08:42
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		352	3338207	3312855	9533	15819	99%	397:32:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	934.5 GB	38.9 MB	47.6 MB	934.6 GB	99%	296.4 KB
2	news.nask.pl	53.8 MB	1.1 MB	145.2 MB	200.2 MB	26%	9.1 KB
3	news.icm.edu.pl	257.3 KB	16.8 KB	63.7 KB	337.8 KB	76%	19.9 KB
4	localhost	3.6 KB	0.0 KB	0.0 KB	3.6 KB	100%	1.8 KB
TOTAL: 4		934.6 GB	40.0 MB	192.9 MB	934.8 GB	99%	294.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 30 04:15:02 - 04:59:59	61808	1.9%	22.91	19.8 GB	2.1%	7713.20
Dec 30 05:00:00 - 05:59:59	113069	3.4%	31.41	36.6 GB	3.9%	10660.43
Dec 30 06:00:00 - 06:59:59	126892	3.8%	35.25	39.6 GB	4.2%	11538.38
Dec 30 07:00:00 - 07:59:59	133073	4.0%	36.96	43.2 GB	4.6%	12589.99
Dec 30 08:00:00 - 08:59:59	134013	4.0%	37.23	40.7 GB	4.4%	11858.43
Dec 30 09:00:00 - 09:59:59	148367	4.5%	41.21	40.2 GB	4.3%	11706.15
Dec 30 10:00:00 - 10:59:59	148093	4.5%	41.14	41.0 GB	4.4%	11951.36
Dec 30 11:00:00 - 11:59:59	144319	4.4%	40.09	40.7 GB	4.4%	11867.98
Dec 30 12:00:00 - 12:59:59	144973	4.4%	40.27	38.4 GB	4.1%	11174.07
Dec 30 13:00:00 - 13:59:59	146683	4.4%	40.75	38.9 GB	4.2%	11333.96
Dec 30 14:00:00 - 14:59:59	139633	4.2%	38.79	38.3 GB	4.1%	11141.91
Dec 30 15:00:00 - 15:59:59	139650	4.2%	38.79	41.4 GB	4.4%	12056.28
Dec 30 16:00:00 - 16:59:59	184601	5.6%	51.28	42.4 GB	4.5%	12342.30
Dec 30 17:00:00 - 17:59:59	169718	5.1%	47.14	44.4 GB	4.7%	12928.48
Dec 30 18:00:00 - 18:59:59	169826	5.1%	47.17	44.7 GB	4.8%	13005.56
Dec 30 19:00:00 - 19:59:59	167782	5.1%	46.61	44.9 GB	4.8%	13090.76
Dec 30 20:00:00 - 20:59:59	169317	5.1%	47.03	45.0 GB	4.8%	13095.33
Dec 30 21:00:00 - 21:59:59	168156	5.1%	46.71	44.9 GB	4.8%	13079.43
Dec 30 22:00:00 - 22:59:59	157387	4.8%	43.72	42.9 GB	4.6%	12503.42
Dec 30 23:00:00 - 23:59:59	134280	4.1%	37.30	37.7 GB	4.0%	10983.37
Dec 31 00:00:00 - 00:59:59	100425	3.0%	27.90	31.1 GB	3.3%	9045.21
Dec 31 01:00:00 - 01:59:59	87863	2.7%	24.41	30.3 GB	3.2%	8830.47
Dec 31 02:00:00 - 02:59:59	84097	2.5%	23.36	28.6 GB	3.1%	8320.19
Dec 31 03:00:00 - 03:59:59	116856	3.5%	32.46	32.0 GB	3.4%	9310.44
Dec 31 04:00:00 - 04:15:02	21968	0.7%	24.35	7.2 GB	0.8%	8374.81
TOTAL: 24:00:00	3312849	100.0%	38.34	934.8 GB	100.0%	11345.54

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	12333	30	403	6	11894
2	newsfeed.pionier.net.pl	4099	201	3461	0	437
3	news.icm.edu.pl	4	0	1	0	3
TOTAL: 3		16436	231	3865	6	12334

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	127
it.tlc.cellulari.android	43
it.comp.os.win.windows10	13
comp.sys.raspberry-pi	10
comp.mobile.android	9
comp.mobile.ipad	8
alt.sex.telephones	5
de.comm.software.mailreader	4
nl.comp.os.linux.techniek	4
hr.alt.cellular.gsm.android	3
comp.sys.mac.vintage	2
de.comp.lang.php	1
it.comp.os.win.windows7	1
it.comp.os.win.windows8	1
TOTAL: 14	231

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

Groups	Count
pl.praca.oferowana	5
bit.listserv.catholic	1
TOTAL: 2	6

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11223
Binary in non-binary group	235
EMP (phl)	71
Scoring filter (8)	54
Scoring filter (9)	40
Scoring filter (10)	13
Scoring filter (15)	6
HTML post	6
Scoring filter (14)	5
Scoring filter (11)	4
Scoring filter (13)	2
Scoring filter (12)	2
Too many newsgroups	1
Too many newsgroups (low_xpost)	1
TOTAL: 14	11663

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	313999	290837	15489	6457	1	485	92%	23:52:48
2	panorama	42988	982	38175	427	1533	288775	2%	23:58:57
3	poznan	14816	180	10131	36	0	0	1%	23:54:54
4	nask	6017	14	4539	0	0	0	0%	23:54:53
5	okapi	0	0	0	0	0	1678	0%	24:00:01
TOTAL: 5		377820	292013	68334	6920	1534	290938	77%	119:41:33

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	52.2 GB	306.3 MB	52.5 GB	639.9 KB/s	185.1 KB	23:52:48
2	panorama	3.1 MB	6.8 MB	9.9 MB	0.1 KB/s	7.2 KB	23:58:57
3	poznan	1.2 MB	158.7 KB	1.3 MB	0.0 KB/s	6.3 KB	23:54:54
4	nask	76.8 KB	0.0 KB	76.8 KB	0.0 KB/s	5.5 KB	23:54:53
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		52.2 GB	313.3 MB	52.5 GB	127.7 KB/s	184.1 KB	119:41:33

Backlog files shrunk by innfeed:

Server	Size
panorama	25.3 MB
TOTAL: 1	25.3 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	289	28	22.9 KB	13	0	00:00:21
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 2		291	28	22.9 KB	13	2	00:00:27

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	675	28	22.9 KB	13	2	0	00:00:27
TOTAL: 1		675	28	22.9 KB	13	2	0	00:00:27

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	0.920	5.809	00:00:21
mon.man.lodz.pl	0.817	5.436	00:00:03
david.man.lodz.pl	0.357	1.737	00:00:01
isvcs01.man.lodz.pl	0.008	0.048	00:00:00
TOTAL: 4	2.102	13.030	00:00:27

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

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

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