Daily Usenet report: Feb 26 04:15:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Feb 26 04:19:53 newsfeed overchan[27660]: input line too long, skipping
Feb 26 10:38:09 newsfeed nnrpd[27146]: SERVER perl filter not defined
Feb 26 10:41:14 newsfeed nnrpd[27197]: SERVER perl filter not defined
Feb 26 18:06:00 newsfeed nnrpd[9670]: SERVER perl filter not defined
Feb 26 18:08:38 newsfeed nnrpd[9714]: SERVER perl filter not defined
Feb 26 22:00:03 newsfeed pgpverify[17370]: pgpverify: verification failed
Feb 27 04:15:02 newsfeed nnrpd[29903]: web.man.lodz.pl rejected Flushing log and syslog files

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	722930	96.8%	80.5 MB	96.1%
innd	10108	1.4%	1.6 MB	2.0%
nnrpd	7353	1.0%	762.7 KB	0.9%
innfeed	6458	0.9%	910.7 KB	1.1%
controlchan	1	0.0%	0.1 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	746852	100.0%	83.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	718396	95.2%
Negative hits	18570	2.5%
Positive hits	17201	2.3%
Cache misses	209	0.0%
TOTAL: 4	754376	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:11.024	0.0%	359	0.000	30.708	569.000
article cleanup	00:00:10.338	0.0%	721661	0.000	0.014	0.052
article logging	00:00:18.830	0.0%	721982	0.000	0.026	0.228
article parse	00:24:06.598	1.7%	50611863	0.008	0.029	0.055
article write	00:06:14.732	0.4%	717721	0.135	0.522	5.111
artlog/artcncl	00:00:00.009	0.0%	358	0.000	0.025	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:01:07.307	0.1%	54781229	0.000	0.001	0.018
hisgrep/artcncl	00:00:02.034	0.0%	349	0.000	5.828	79.500
hishave/artcncl	00:00:00.893	0.0%	359	0.000	2.487	143.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:08:21.221	4.7%	754580	0.443	5.435	15.101
history sync	00:00:00.019	0.0%	470	0.000	0.040	1.000
history write	01:34:44.411	6.6%	718854	1.417	7.908	24.851
hiswrite/artcncl	00:00:00.146	0.0%	10	0.000	14.600	110.000
idle	18:29:03.953	77.0%	36709195	0.391	1.813	15.160
nntp read	00:21:37.600	1.5%	50118307	0.013	0.026	0.041
overview write	00:00:04.529	0.0%	717721	0.000	0.006	0.035
perl filter	01:35:48.247	6.7%	718853	3.695	7.996	11.213
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:01:27.401	0.1%	1473260	0.013	0.059	0.132
TOTAL: 23:59:27.251	23:43:19.292	98.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.137	0.0%	37836	0.000	0.004	0.167
article prepare	00:00:00.008	0.0%	12586	0.000	0.001	0.083
article read	00:00:00.238	0.0%	3084	0.000	0.077	1.000
backlog stats	00:00:00.113	0.0%	234216	0.000	0.000	0.019
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.351	0.0%	151549	0.000	0.009	1.000
data write	00:00:04.432	0.0%	117488	0.000	0.038	30.000
idle	23:59:05.040	100.0%	234216	0.000	368.656	20598.000
status file	00:00:01.911	0.0%	193	0.000	9.902	167.500
TOTAL: 23:59:18.171	23:59:13.230	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	05:23:36.210	99.8%	4938	0.000	3931.999	450047.250
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.545	0.0%	12806	0.000	0.043	2.000
readart	00:00:17.094	0.1%	913	0.000	18.723	53.921
TOTAL: 05:24:11.312	05:23:53.849	99.9%	-	-	-	-

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
group-admin@isc.org	0	0	0	1	0	0
TOTAL	0	0	0	1	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	356	718762	715473	117	3172	99%	177:08:42
2	news.nask.pl	2	17512	2695	14059	758	15%	24:18:59
3	news.icm.edu.pl	45	265	48	208	9	18%	17:01:36
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		408	736543	718220	14384	3939	97%	218:29:17

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	193.8 GB	10.7 MB	121.6 MB	194.0 GB	99%	283.0 KB
2	news.nask.pl	12.2 MB	2.0 MB	2.1 MB	16.3 MB	74%	4.8 KB
3	news.icm.edu.pl	1.4 MB	40.5 KB	162.9 KB	1.6 MB	87%	28.5 KB
4	localhost	6.2 KB	0.0 KB	0.0 KB	6.2 KB	100%	1.6 KB
TOTAL: 4		193.9 GB	12.8 MB	123.8 MB	194.0 GB	99%	281.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 26 04:15:02 - 04:59:59	37116	5.2%	13.76	12.5 GB	6.4%	4854.06
Feb 26 05:00:00 - 05:59:59	38294	5.3%	10.64	12.6 GB	6.5%	3663.81
Feb 26 06:00:00 - 06:59:59	62473	8.7%	17.35	22.5 GB	11.6%	6567.83
Feb 26 07:00:00 - 07:59:59	77971	10.9%	21.66	27.1 GB	14.0%	7900.85
Feb 26 08:00:00 - 08:59:59	74011	10.3%	20.56	26.8 GB	13.8%	7798.77
Feb 26 09:00:00 - 09:59:59	42929	6.0%	11.92	13.0 GB	6.7%	3774.23
Feb 26 10:00:00 - 10:59:59	9824	1.4%	2.73	1.6 GB	0.8%	456.47
Feb 26 11:00:00 - 11:59:59	11149	1.6%	3.10	1.3 GB	0.7%	372.92
Feb 26 12:00:00 - 12:59:59	11506	1.6%	3.20	1.3 GB	0.7%	367.13
Feb 26 13:00:00 - 13:59:59	10647	1.5%	2.96	1.3 GB	0.6%	365.39
Feb 26 14:00:00 - 14:59:59	12641	1.8%	3.51	1.2 GB	0.6%	355.83
Feb 26 15:00:00 - 15:59:59	11802	1.6%	3.28	1.0 GB	0.5%	291.46
Feb 26 16:00:00 - 16:59:59	11671	1.6%	3.24	940.7 MB	0.5%	267.59
Feb 26 17:00:00 - 17:59:59	11164	1.6%	3.10	938.1 MB	0.5%	266.83
Feb 26 18:00:00 - 18:59:59	10290	1.4%	2.86	1001.2 MB	0.5%	284.78
Feb 26 19:00:00 - 19:59:59	13663	1.9%	3.80	1.4 GB	0.7%	418.99
Feb 26 20:00:00 - 20:59:59	14394	2.0%	4.00	1.4 GB	0.7%	395.03
Feb 26 21:00:00 - 21:59:59	11806	1.6%	3.28	1.1 GB	0.5%	309.94
Feb 26 22:00:00 - 22:59:59	11118	1.5%	3.09	991.8 MB	0.5%	282.13
Feb 26 23:00:00 - 23:59:59	11629	1.6%	3.23	1.1 GB	0.6%	317.58
Feb 27 00:00:00 - 00:59:59	34130	4.8%	9.48	8.1 GB	4.2%	2360.33
Feb 27 01:00:00 - 01:59:59	44500	6.2%	12.36	12.2 GB	6.3%	3558.82
Feb 27 02:00:00 - 02:59:59	62812	8.7%	17.45	18.6 GB	9.6%	5429.97
Feb 27 03:00:00 - 03:59:59	64715	9.0%	17.98	19.2 GB	9.9%	5602.59
Feb 27 04:00:00 - 04:15:02	16064	2.2%	17.81	4.9 GB	2.5%	5655.05
TOTAL: 24:00:00	718319	100.0%	8.31	193.9 GB	100.0%	2352.67

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3466	177	2075	23	1191
2	news.nask.pl	778	8	731	9	30
3	news.icm.edu.pl	9	0	3	1	5
TOTAL: 3		4253	185	2809	33	1226

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	67
it.tlc.cellulari.android	33
it.comp.os.linux.ubuntu	16
it.comp.os.win.windows7	15
hr.ponuda.hardver.komponente	12
comp.mobile.ipad	11
comp.sys.raspberry-pi	7
it.comp.os.win.windows8	5
nl.comp.os.linux.techniek	3
comp.mobile.android	3
de.comp.lang.php	2
hr.alt.cellular.gsm.android	2
de.comm.software.mailreader	2
it.discussioni.energia	2
it.tlc.cellulari.iphone	1
alt.sex.telephones	1
hr.ponuda.hardver.ostalo	1
nl.comp.sys.android	1
de.comm.provider.telefonie	1
TOTAL: 19	185

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

Groups	Count
pl.praca.oferowana	16
pl.sci.historia	16
bit.listserv.catholic	1
TOTAL: 3	33

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	880
EMP (md5)	14
HTML post	7
Attached HTML file	2
Scoring filter (12)	1
TOTAL: 5	904

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	38553	1204	36466	203	1	0	3%	23:59:54
2	icm	46703	727	34923	436	0	20	1%	23:57:29
3	nask	23736	136	15402	418	0	0	0%	23:54:17
4	poznan	3589	12	2422	13	0	0	0%	23:49:00
5	okapi	0	0	0	0	0	2349	0%	24:00:02
TOTAL: 5		112581	2079	89213	1070	1	2369	1%	119:40:42

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	57.2 MB	24.1 MB	81.2 MB	1.0 KB/s	71.5 KB	23:57:29
2	panorama	4.5 MB	603.9 KB	5.1 MB	0.1 KB/s	3.7 KB	23:59:54
3	nask	1.2 MB	96.4 MB	97.7 MB	1.2 KB/s	180.5 KB	23:54:17
4	poznan	32.5 KB	33.9 KB	66.4 KB	0.0 KB/s	2.7 KB	23:49:00
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		63.0 MB	121.1 MB	184.1 MB	0.4 KB/s	59.9 KB	119:40:42

Backlog files shrunk by innfeed:

Server	Size
okapi	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	326	619.7 KB	288	0	00:00:06
2	bursztyn.p.lodz.pl	1	278	39.4 MB	6	0	01:00:36
3	lze200.lze.lodz.pl	11	147	353.9 KB	13	0	02:20:35
4	pc-212-51-218-225.p.lodz.pl	4	89	174.0 KB	3	0	01:22:19
5	web.man.lodz.pl	288	70	58.0 KB	32	0	00:00:22
6	212.51.203.199	2	3	17.5 KB	1	0	00:09:23
7	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 7		598	913	40.6 MB	343	4	05:24:10

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.p.lodz.pl	5	367	39.6 MB	9	0	02:22:55
2	*.cm.p.lodz.pl	288	326	619.7 KB	288	0	00:00:06
3	*.lze.lodz.pl	11	147	353.9 KB	13	0	02:20:35
4	*.man.lodz.pl	677	70	58.0 KB	32	4	00:30:28
5	unresolved	2	3	17.5 KB	1	0	00:09:23
6	*.toya.net.pl	71	0	0.0 KB	0	0	00:00:41
TOTAL: 6		1054	913	40.6 MB	343	4	05:24:10

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
lze200.lze.lodz.pl	0.040	0.196	02:20:35
pc-212-51-218-225.p.lodz.pl	0.026	0.070	01:22:19
bursztyn.p.lodz.pl	0.097	0.356	01:00:36
pc-vicki.man.lodz.pl	0.008	0.008	00:30:00
212.51.203.199	0.000	0.036	00:09:23
staticline41435.toya.net.pl	0.253	0.937	00:00:41
web.man.lodz.pl	0.955	3.938	00:00:22
pc-skrzep2.cm.p.lodz.pl	1.080	3.971	00:00:06
mon.man.lodz.pl	0.959	3.810	00:00:03
david.man.lodz.pl	0.365	1.230	00:00:01
isvcs01.man.lodz.pl	0.027	0.057	00:00:00
?	0.004	0.038	00:00:00
TOTAL: 12	3.814	14.647	05:24:10

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	71
pc-vicki.man.lodz.pl	1
TOTAL: 4	456

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	3
TOTAL: 1	3

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	2	0
lze200.lze.lodz.pl	1	0
pc-vicki.man.lodz.pl	1	0
TOTAL: 3	4	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	326	35.7%
2	pl	309	33.8%
3	alt	278	30.4%
TOTAL: 3		913	100.0%

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

Newsgroup		Count
1	lodman.info	326
2	alt.binaries.pictures.sex	143
3	alt.binaries.pictures.erotica.groupsex	78
4	pl.rec.kuchnia	75
5	pl.comp.pecet	58
6	pl.rec.dom	51
7	pl.misc.kolej	48
8	alt.binaries.erotica.pornstars.90s	44
9	pl.misc.elektronika	41
10	pl.comp.os.ms-windows.winnt	25
11	alt.binaries.pictures.erotica.pornstar	11
12	pl.misc.telefonia.gsm	6
13	pl.rec.radio.amatorskie	3
14	pl.regionalne.lodz	2
15	alt.sex.erotica.female	1
16	alt.binaries.pictures.groupsex	1
TOTAL: 16		913

Daily Usenet report

Feb 26 04:15:02 -- Feb 27 04:15:02