Daily Usenet report: Aug 7 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Aug 7 08:41:22 newsfeed overchan[6708]: input line too long, skipping
Aug 7 08:42:43 newsfeed overchan[6708]: input line too long, skipping
Aug 7 08:43:07 newsfeed overchan[6708]: input line too long, skipping
Aug 7 13:41:15 newsfeed overchan[6708]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2927378	97.6%	334.8 MB	97.3%
innfeed	43041	1.4%	5.0 MB	1.5%
innd	23073	0.8%	3.7 MB	1.1%
nnrpd	4764	0.2%	501.4 KB	0.1%
controlchan	5	0.0%	0.8 KB	0.0%
overchan	4	0.0%	0.7 KB	0.0%
TOTAL: 6	2998265	100.0%	344.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2908062	96.8%
Negative hits	81348	2.7%
Positive hits	13535	0.5%
Cache misses	120	0.0%
TOTAL: 4	3003065	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.766	0.0%	242	0.000	11.430	783.000
article cleanup	00:00:39.251	0.0%	2926699	0.010	0.013	0.018
article logging	00:01:47.915	0.1%	2927216	0.026	0.037	0.095
article parse	01:09:58.334	4.9%	223378754	0.013	0.019	0.032
article write	00:22:49.530	1.6%	2919365	0.383	0.469	0.824
artlog/artcncl	00:00:00.005	0.0%	235	0.000	0.021	1.000
artlog/artparse	00:00:00.001	0.0%	1	1.000	1.000	1.000
data move	00:03:06.335	0.2%	241547823	0.001	0.001	0.002
hisgrep/artcncl	00:00:00.349	0.0%	236	0.000	1.479	24.000
hishave/artcncl	00:00:00.060	0.0%	242	0.000	0.248	2.722
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:23:11.211	1.6%	3019557	0.011	0.461	4.675
history sync	00:00:00.014	0.0%	290	0.000	0.048	0.500
history write	01:18:25.182	5.4%	2922935	0.090	1.610	7.554
hiswrite/artcncl	00:00:00.010	0.0%	6	0.000	1.667	10.000
idle	13:06:50.360	54.6%	163704756	0.230	0.288	0.390
nntp read	01:26:28.960	6.0%	221082122	0.018	0.023	0.034
overview write	00:00:15.410	0.0%	2919365	0.004	0.005	0.007
perl filter	05:24:55.739	22.6%	2922934	5.829	6.670	7.794
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:46.840	0.3%	5859933	0.040	0.049	0.063
TOTAL: 24:00:03.005	23:23:18.272	97.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.176	0.0%	58361	0.000	0.003	0.012
article prepare	00:00:00.005	0.0%	7026	0.000	0.001	0.042
article read	00:00:51.855	0.1%	1749	0.000	29.648	501.800
backlog stats	00:00:00.154	0.0%	179778	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	5	0.000	0.000	0.000
data read	00:00:02.296	0.0%	96045	0.007	0.024	0.064
data write	00:00:03.366	0.0%	74966	0.018	0.045	0.082
idle	23:52:37.255	99.9%	179778	289.984	478.130	812.069
status file	00:00:13.174	0.0%	16350	0.575	0.806	1.060
TOTAL: 23:54:04.621	23:53:48.281	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:18.050	58.8%	3046	0.000	5.926	47.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.176	0.6%	6808	0.000	0.026	0.667
readart	00:00:00.008	0.0%	70	0.000	0.114	0.500
TOTAL: 00:00:30.717	00:00:18.234	59.4%	-	-	-	-

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
control-redatomik@redatomik.org	2	0	1	0	0	3
TOTAL	2	0	1	0	0	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1096	2919304	2908802	6725	3777	99%	367:14:46
2	news.nask.pl	2	16968	10647	2788	3533	62%	23:59:03
3	news.icm.edu.pl	42	252	31	206	15	12%	16:00:48
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		1141	2936524	2919480	9719	7325	99%	407:14:37

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	846.3 GB	19.0 MB	20.2 MB	846.3 GB	99%	304.7 KB
2	news.nask.pl	47.4 MB	659.1 KB	20.3 MB	68.3 MB	69%	4.9 KB
3	news.icm.edu.pl	1.3 MB	65.1 KB	1.1 MB	2.4 MB	53%	54.2 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		846.3 GB	19.8 MB	41.5 MB	846.4 GB	99%	303.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 7 04:15:02 - 04:59:59	84236	2.9%	31.22	24.8 GB	2.9%	9636.44
Aug 7 05:00:00 - 05:59:59	116033	4.0%	32.23	34.8 GB	4.1%	10140.53
Aug 7 06:00:00 - 06:59:59	115461	4.0%	32.07	33.4 GB	4.0%	9738.07
Aug 7 07:00:00 - 07:59:59	124791	4.3%	34.66	36.2 GB	4.3%	10550.06
Aug 7 08:00:00 - 08:59:59	122911	4.2%	34.14	35.0 GB	4.2%	10206.05
Aug 7 09:00:00 - 09:59:59	124348	4.3%	34.54	36.0 GB	4.3%	10478.68
Aug 7 10:00:00 - 10:59:59	128979	4.4%	35.83	37.5 GB	4.5%	10934.18
Aug 7 11:00:00 - 11:59:59	121828	4.2%	33.84	36.8 GB	4.4%	10721.56
Aug 7 12:00:00 - 12:59:59	120044	4.1%	33.35	37.6 GB	4.5%	10950.85
Aug 7 13:00:00 - 13:59:59	121092	4.1%	33.64	35.3 GB	4.2%	10280.10
Aug 7 14:00:00 - 14:59:59	119924	4.1%	33.31	34.5 GB	4.1%	10056.06
Aug 7 15:00:00 - 15:59:59	118543	4.1%	32.93	34.4 GB	4.1%	10029.40
Aug 7 16:00:00 - 16:59:59	123785	4.2%	34.38	34.7 GB	4.1%	10095.76
Aug 7 17:00:00 - 17:59:59	120107	4.1%	33.36	33.7 GB	4.0%	9819.55
Aug 7 18:00:00 - 18:59:59	119590	4.1%	33.22	33.6 GB	4.0%	9776.28
Aug 7 19:00:00 - 19:59:59	128449	4.4%	35.68	35.7 GB	4.2%	10398.51
Aug 7 20:00:00 - 20:59:59	119908	4.1%	33.31	32.3 GB	3.8%	9401.57
Aug 7 21:00:00 - 21:59:59	130593	4.5%	36.28	35.9 GB	4.3%	10464.74
Aug 7 22:00:00 - 22:59:59	132141	4.5%	36.71	36.5 GB	4.3%	10631.48
Aug 7 23:00:00 - 23:59:59	124846	4.3%	34.68	35.2 GB	4.2%	10248.61
Aug 8 00:00:00 - 00:59:59	108543	3.7%	30.15	31.9 GB	3.8%	9302.37
Aug 8 01:00:00 - 01:59:59	123243	4.2%	34.23	36.2 GB	4.3%	10537.37
Aug 8 02:00:00 - 02:59:59	127000	4.4%	35.28	36.8 GB	4.4%	10719.82
Aug 8 03:00:00 - 03:59:59	114870	3.9%	31.91	35.1 GB	4.2%	10209.95
Aug 8 04:00:00 - 04:15:02	28024	1.0%	31.07	8.6 GB	1.0%	9999.36
TOTAL: 24:00:00	2919289	100.0%	33.79	842.6 GB	100.0%	10225.79

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4122	215	3503	2	402
2	news.nask.pl	3717	23	261	6	3427
3	news.icm.edu.pl	15	0	1	0	14
TOTAL: 3		7854	238	3765	8	3843

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	182
comp.mobile.ipad	16
it.comp.os.win.windows10	12
it.tlc.cellulari.android	11
de.comp.os.os2	4
hr.ponuda.hardver.komponente	3
comp.mobile.android	3
comp.sys.raspberry-pi	2
it.comp.os.win.windows7	2
hr.alt.cellular.gsm.android	1
uk.rec.cycling.moderated	1
alt.sex.telephones	1
TOTAL: 12	238

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3081
Binary in non-binary group	89
Scoring filter (8)	70
Scoring filter (9)	40
EMP (phl)	18
Scoring filter (11)	8
Scoring filter (10)	8
Scoring filter (12)	6
Too many newsgroups	2
Scoring filter (13)	1
Scoring filter (24)	1
HTML post	1
TOTAL: 12	3325

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	345
	news.nask.pl	172
	TOTAL: 2	517
TOTAL: 1		517

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	43111	560	15068	266	13	42672	1%	23:58:13
2	poznan	17555	207	10362	39	0	0	1%	23:50:01
3	icm	28071	102	20253	5	0	0	0%	23:59:29
4	nask	5912	4	3923	0	0	0	0%	23:58:08
5	okapi	0	0	0	0	0	2631	0%	23:50:01
TOTAL: 5		94649	873	49606	310	13	45303	0%	119:35:52

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	8.3 MB	31.7 KB	8.3 MB	0.1 KB/s	79.6 KB	23:59:29
2	panorama	3.8 MB	975.1 KB	4.8 MB	0.1 KB/s	5.9 KB	23:58:13
3	poznan	881.3 KB	123.1 KB	1004.4 KB	0.0 KB/s	4.1 KB	23:50:01
4	nask	7.1 KB	0.0 KB	7.1 KB	0.0 KB/s	1.8 KB	23:58:08
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:01
TOTAL: 5		13.0 MB	1.1 MB	14.1 MB	0.0 KB/s	12.2 KB	119:35:52

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	Rej	Elapsed
1	web.man.lodz.pl	288	70	78.4 KB	30	0	0	00:00:24
TOTAL: 1		288	70	78.4 KB	30	0	0	00:00:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	672	70	78.4 KB	30	0	0	00:00:29
TOTAL: 1		672	70	78.4 KB	30	0	0	00:00:29

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.296	2.964	00:00:24
mon.man.lodz.pl	1.144	2.896	00:00:04
david.man.lodz.pl	0.364	0.940	00:00:01
TOTAL: 3	2.804	6.800	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	70	100.0%
TOTAL: 1		70	100.0%

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

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

Daily Usenet report

Aug 7 04:15:02 -- Aug 8 04:15:02