Daily Usenet report: Feb 22 04:15:02

Unknown entries from news log file:

First 50 / 4031 lines (1.2%)

Feb 22 04:18:02 newsfeed nnrpd[634831]: nms2.man.lodz.pl rejected Expiring process 634798
Feb 22 06:10:32 newsfeed overchan[634561]: input line too long, skipping
Feb 22 09:05:43 newsfeed nnrpd[648056]: SERVER perl filter not defined
Feb 22 09:08:08 newsfeed nnrpd[648090]: SERVER perl filter not defined
Feb 22 09:09:34 newsfeed nnrpd[648102]: SERVER perl filter not defined
Feb 22 10:21:37 newsfeed innfeed[1445]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Feb 22 10:21:37 newsfeed innfeed[1445]: SM: storage method 'cnfs' failed initialization
Feb 22 10:21:37 newsfeed innfeed[1445]: SM: one or more storage methods failed initialization
Feb 22 10:21:37 newsfeed innfeed[1445]: Storage manager initialization failed -- it is OK after a change in storage methods
Feb 22 10:21:37 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Feb 22 10:21:37 newsfeed innd: SM: storage method 'cnfs' failed initialization
Feb 22 10:21:37 newsfeed innd: SM: one or more storage methods failed initialization
Feb 22 10:22:58 newsfeed nnrpd[1454]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:23:32 newsfeed nnrpd[1481]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:24:02 newsfeed nnrpd[1646]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:24:32 newsfeed nnrpd[1650]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:25:01 newsfeed nnrpd[1374]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:25:02 newsfeed nnrpd[1749]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:25:31 newsfeed nnrpd[1762]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:25:32 newsfeed nnrpd[1763]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:26:01 newsfeed nnrpd[1919]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:26:02 newsfeed nnrpd[1920]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:26:31 newsfeed nnrpd[2419]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:26:32 newsfeed nnrpd[2420]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:27:01 newsfeed nnrpd[2434]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:27:04 newsfeed nnrpd[2435]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:27:31 newsfeed nnrpd[2438]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:27:34 newsfeed nnrpd[2439]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:28:01 newsfeed nnrpd[2448]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:28:04 newsfeed nnrpd[2449]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:28:31 newsfeed nnrpd[2452]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:28:34 newsfeed nnrpd[2453]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:29:01 newsfeed nnrpd[2462]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:29:07 newsfeed nnrpd[2463]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:29:31 newsfeed nnrpd[2466]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:29:39 newsfeed nnrpd[2467]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:30:01 newsfeed nnrpd[2548]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:30:13 newsfeed nnrpd[2571]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:30:31 newsfeed nnrpd[2574]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:30:45 newsfeed nnrpd[2576]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:31:01 newsfeed nnrpd[2584]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:31:16 newsfeed nnrpd[2587]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:31:31 newsfeed nnrpd[2588]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:31:48 newsfeed nnrpd[2594]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:32:01 newsfeed nnrpd[2598]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:32:20 newsfeed nnrpd[2601]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:32:31 newsfeed nnrpd[2602]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:32:50 newsfeed nnrpd[2702]: newsfeed.pionier.net.pl noperm ihave without permission
Feb 22 10:33:01 newsfeed nnrpd[2705]: news.icm.edu.pl noperm ihave without permission
Feb 22 10:33:20 newsfeed nnrpd[2708]: newsfeed.pionier.net.pl noperm ihave without permission

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	42722	62.2%	5.1 MB	67.6%
nnrpd	23805	34.7%	2.2 MB	29.5%
innfeed	1085	1.6%	110.0 KB	1.4%
innd	1030	1.5%	105.2 KB	1.4%
overchan	3	0.0%	0.4 KB	0.0%
controlchan	3	0.0%	0.2 KB	0.0%
TOTAL: 6	68648	100.0%	7.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	41750	97.9%
Negative hits	694	1.6%
Positive hits	200	0.5%
Cache misses	14	0.0%
TOTAL: 4	42658	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.522	0.0%	17	0.000	30.706	67.000
article cleanup	00:00:00.209	0.0%	42067	0.000	0.005	0.013
article logging	00:00:00.896	0.0%	42075	0.000	0.021	0.033
article parse	00:00:01.303	0.0%	132553	0.000	0.010	0.014
article write	00:00:05.095	0.0%	41946	0.042	0.121	12.000
artlog/artcncl	00:00:00.000	0.0%	17	0.000	0.000	0.000
data move	00:00:00.250	0.0%	183450	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.263	0.0%	17	0.000	15.471	20.222
hishave/artcncl	00:00:00.146	0.0%	17	0.000	8.588	12.667
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:04:57.853	0.3%	43042	5.568	6.920	12.876
history sync	00:00:00.002	0.0%	398	0.000	0.005	0.333
history write	00:05:24.944	0.4%	41979	6.582	7.741	17.000
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:39:36.890	99.2%	173385	60.176	491.259	5947.693
nntp read	00:00:02.909	0.0%	128089	0.000	0.023	0.030
overview write	00:00:00.097	0.0%	41946	0.000	0.002	0.008
perl filter	00:00:38.948	0.0%	41979	0.599	0.928	30.000
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.423	0.0%	101170	0.000	0.014	0.021
TOTAL: 23:51:03.921	23:50:51.750	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.029	0.0%	17127	0.000	0.002	0.008
article prepare	00:00:00.000	0.0%	60	0.000	0.000	0.000
article read	00:00:00.000	0.0%	15	0.000	0.000	0.000
backlog stats	00:00:00.021	0.0%	29371	0.000	0.001	0.034
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.197	0.0%	20732	0.000	0.010	0.500
data write	00:00:00.147	0.0%	3815	0.000	0.039	0.167
idle	23:45:38.066	100.0%	29371	250.524	2912.331	22242.630
status file	00:00:00.191	0.0%	380	0.000	0.503	2.000
TOTAL: 23:45:39.663	23:45:38.651	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	08:51:34.998	99.8%	16304	0.000	1956.268	300359.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.494	0.0%	34387	0.000	0.014	0.500
readart	00:00:00.000	0.0%	2	0.000	0.000	0.000
TOTAL: 08:52:23.305	08:51:35.492	99.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	27
flushlogs	2
go	2
logmode	2
lowmark	1
mode	152
name	3
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	197

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	17	41876	41787	0	89	99%	10:53:47
2	news.icm.edu.pl	6	354	231	96	27	65%	05:23:32
3	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 3		28	42234	42022	96	116	99%	16:17:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	401.4 MB	805.4 KB	878.7 KB	403.0 MB	99%	9.9 KB
2	news.icm.edu.pl	3.3 MB	236.5 KB	305.6 KB	3.8 MB	86%	15.0 KB
3	localhost	5.6 KB	0.0 KB	0.0 KB	5.6 KB	100%	1.4 KB
TOTAL: 3		404.6 MB	1.0 MB	1.2 MB	406.8 MB	99%	9.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 22 04:15:02 - 04:59:59	2770	6.5%	1.03	28.8 MB	0.0%	10.92
Feb 22 05:00:00 - 05:59:59	4017	9.4%	1.12	38.6 MB	0.0%	10.98
Feb 22 06:00:00 - 06:59:59	3923	9.2%	1.09	43.0 MB	0.0%	12.22
Feb 22 07:00:00 - 07:59:59	4552	10.7%	1.26	40.2 MB	0.0%	11.44
Feb 22 08:00:00 - 08:59:59	5459	12.8%	1.52	52.1 MB	0.0%	14.83
Feb 22 09:00:00 - 09:59:59	5946	14.0%	1.65	76.4 MB	0.0%	21.72
Feb 22 10:00:00 - 10:59:59	2139	5.0%	0.59	45.5 MB	0.0%	12.93
Feb 22 11:00:00 - 11:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 12:00:00 - 12:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 13:00:00 - 13:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 14:00:00 - 14:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 15:00:00 - 15:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 16:00:00 - 16:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 17:00:00 - 17:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 18:00:00 - 18:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 19:00:00 - 19:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 20:00:00 - 20:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 21:00:00 - 21:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 22:00:00 - 22:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 22 23:00:00 - 23:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 23 00:00:00 - 00:59:59	1	0.0%	0.00	1.5 KB	0.0%	0.00
Feb 23 01:00:00 - 01:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 23 02:00:00 - 02:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Feb 23 03:00:00 - 03:59:59	11729	27.5%	3.26	84.2 MB	0.0%	23.96
Feb 23 04:00:00 - 04:15:01	2038	4.8%	2.26	21.3 MB	0.0%	24.18
TOTAL: 23:59:59	42574	100.0%	0.49	0.0 KB	100.0%	0.00

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.pionier.net.pl	97	27	63	7
2	news.icm.edu.pl	34	1	26	7
TOTAL: 2		131	28	89	14

Unwanted newsgroups [Top 20]:

Newsgroup	Count
eternal-september.talk	6
uk.railway	3
de.rec.sf.startrek	3
it.tlc.cellulari.android	3
alt.comp.software.seamonkey	2
rocksolid.shared.test	2
eternal-september.test	2
comp.mobile.android	2
it.comp.os.win.windows7	2
nl.comp.os.linux.techniek	1
alt.comp.software.firefox	1
comp.sys.mac.vintage	1
TOTAL: 12	28

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	3
Scoring filter (11)	1
Scoring filter (12)	1
Scoring filter (8)	1
TOTAL: 4	6

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	7
	news.icm.edu.pl	1
	TOTAL: 2	8
TOTAL: 1		8

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Spool	%Took	Elapsed
1	icm	3382	15	2909	0	0%	07:22:22
2	okapi	0	0	0	117	0%	23:49:52
3	nask	0	0	0	16576	0%	23:49:52
4	poznan	170	0	167	0	0%	04:55:28
5	panorama	0	0	0	17377	0%	23:49:52
TOTAL: 5		3552	15	3076	34070	0%	83:47:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	TotalVol	Vol/Art	Elapsed
1	icm	58.9 KB	58.9 KB	3.9 KB	07:22:22
2	okapi	0.0 KB	0.0 KB	0	23:49:52
3	nask	0.0 KB	0.0 KB	0	23:49:52
4	poznan	0.0 KB	0.0 KB	0	04:55:28
5	panorama	0.0 KB	0.0 KB	0	23:49:52
TOTAL: 5		58.9 KB	58.9 KB	3.9 KB	83:47:26

Backlog files shrunk by innfeed:

Server	Size
panorama	1.4 MB
TOTAL: 1	1.4 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	287	2	2.4 KB	1	0	00:00:08
2	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 2		291	2	2.4 KB	1	4	08:52:23

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	1726	2	2.4 KB	1	4	00:00:21
2	unresolved	103	0	0.0 KB	0	0	00:00:36
3	*.toya.net.pl	2	0	0.0 KB	0	0	01:00:04
4	*.icm.edu.pl	1991	0	0.0 KB	0	0	00:02:59
5	*.pionier.net.pl	2059	0	0.0 KB	0	0	07:48:21
TOTAL: 5		5881	2	2.4 KB	1	4	08:52:23

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
newsfeed.pionier.net.pl	7.301	8.624	07:48:21
staticline-31-182-233-191.toya.net.pl	0.001	0.013	01:00:04
news.icm.edu.pl	6.660	8.490	00:02:59
118.123.105.85	0.000	0.009	00:00:24
nms2.man.lodz.pl	4.671	5.863	00:00:12
web.man.lodz.pl	0.997	1.197	00:00:08
125.82.243.184	0.005	0.005	00:00:08
80.111.142.213	0.014	0.023	00:00:02
212.51.192.185	0.329	0.412	00:00:00
isvcs01.man.lodz.pl	0.029	0.017	00:00:00
80.66.88.211	0.006	0.000	00:00:00
TOTAL: 11	20.013	24.653	08:52:23

Curious NNRP server explorers [Top 20]:

System	Conn
newsfeed.pionier.net.pl	2059
news.icm.edu.pl	1991
nms2.man.lodz.pl	1435
212.51.192.185	96
80.111.142.213	4
staticline-31-182-233-191.toya.net.pl	2
118.123.105.85	1
80.66.88.211	1
125.82.243.184	1
TOTAL: 9	5590

NNRP unrecognized commands (by host):

System	Conn
80.66.88.211	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
#003	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
staticline-31-182-233-191.toya.net.pl	2	0
80.66.88.211	1	1
TOTAL: 2	3	1

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	2	100.0%
TOTAL: 1		2	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	2
TOTAL: 1		2

Daily Usenet report

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