Daily Usenet report for news.cyber23.de: Dec 4 03:00:00

Unknown entries from news log file:

First 50 / 150 lines (33.3%)

Dec 4 03:12:12 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/98 to /usr/local/news/spool/articles/de/alt/1/98: Not a directory
Dec 4 03:24:10 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/99 to /usr/local/news/spool/articles/de/alt/1/99: Not a directory
Dec 4 03:36:30 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/100 to /usr/local/news/spool/articles/de/alt/1/100: Not a directory
Dec 4 03:48:13 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/101 to /usr/local/news/spool/articles/de/alt/1/101: Not a directory
Dec 4 04:00:11 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/102 to /usr/local/news/spool/articles/de/alt/1/102: Not a directory
Dec 4 04:13:31 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/103 to /usr/local/news/spool/articles/de/alt/1/103: Not a directory
Dec 4 04:25:42 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/104 to /usr/local/news/spool/articles/de/alt/1/104: Not a directory
Dec 4 04:38:00 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/105 to /usr/local/news/spool/articles/de/alt/1/105: Not a directory
Dec 4 04:51:17 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/106 to /usr/local/news/spool/articles/de/alt/1/106: Not a directory
Dec 4 05:05:04 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/107 to /usr/local/news/spool/articles/de/alt/1/107: Not a directory
Dec 4 05:17:45 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/108 to /usr/local/news/spool/articles/de/alt/1/108: Not a directory
Dec 4 05:31:51 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/109 to /usr/local/news/spool/articles/de/alt/1/109: Not a directory
Dec 4 05:45:59 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/110 to /usr/local/news/spool/articles/de/alt/1/110: Not a directory
Dec 4 06:01:13 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/111 to /usr/local/news/spool/articles/de/alt/1/111: Not a directory
Dec 4 06:15:14 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/112 to /usr/local/news/spool/articles/de/alt/1/112: Not a directory
Dec 4 06:28:36 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/113 to /usr/local/news/spool/articles/de/alt/1/113: Not a directory
Dec 4 06:42:44 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/114 to /usr/local/news/spool/articles/de/alt/1/114: Not a directory
Dec 4 06:55:24 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/115 to /usr/local/news/spool/articles/de/alt/1/115: Not a directory
Dec 4 07:08:06 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/116 to /usr/local/news/spool/articles/de/alt/1/116: Not a directory
Dec 4 07:21:12 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/117 to /usr/local/news/spool/articles/de/alt/1/117: Not a directory
Dec 4 07:35:08 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/118 to /usr/local/news/spool/articles/de/alt/1/118: Not a directory
Dec 4 07:48:06 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/119 to /usr/local/news/spool/articles/de/alt/1/119: Not a directory
Dec 4 08:02:02 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/120 to /usr/local/news/spool/articles/de/alt/1/120: Not a directory
Dec 4 08:14:18 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/121 to /usr/local/news/spool/articles/de/alt/1/121: Not a directory
Dec 4 08:26:57 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/122 to /usr/local/news/spool/articles/de/alt/1/122: Not a directory
Dec 4 08:39:30 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/123 to /usr/local/news/spool/articles/de/alt/1/123: Not a directory
Dec 4 08:51:44 news innd[29900]: tradspool: could not symlink /usr/local/news/spool/articles/alt/provider/earthlink/124 to /usr/local/news/spool/articles/de/alt/1/124: Not a directory
Dec 4 08:52:04 news nnrpd[48292]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 08:53:04 news nnrpd[48302]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 08:54:04 news nnrpd[48461]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 08:55:05 news nnrpd[48501]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 08:56:04 news nnrpd[48511]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 08:57:04 news nnrpd[48521]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 08:58:05 news nnrpd[48531]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 08:59:04 news nnrpd[48541]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:00:10 news nnrpd[48570]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:01:04 news nnrpd[48581]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:02:03 news nnrpd[48591]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:03:03 news nnrpd[48601]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:04:04 news nnrpd[48751]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:05:06 news nnrpd[48768]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:05:07 news nnrpd[48770]: aftr-95-222-31-66.unity-media.net rejected Not a directory writing SMstore file -- throttling
Dec 4 09:05:07 news nnrpd[48769]: aftr-95-222-31-66.unity-media.net rejected Not a directory writing SMstore file -- throttling
Dec 4 09:06:04 news nnrpd[48780]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:07:03 news nnrpd[48790]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:08:03 news nnrpd[48800]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:09:04 news nnrpd[48810]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:10:05 news nnrpd[48827]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:11:03 news nnrpd[48844]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling
Dec 4 09:12:04 news nnrpd[48856]: neuromail.unhb.de rejected Not a directory writing SMstore file -- throttling

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	599358	85.6%	50.2 MB	78.2%
innd	68832	9.8%	10.8 MB	16.8%
rnews	17163	2.5%	1.6 MB	2.6%
nnrpd	11989	1.7%	1.2 MB	1.9%
innfeed	2060	0.3%	277.5 KB	0.4%
batcher	538	0.1%	44.9 KB	0.1%
controlchan	2	0.0%	0.1 KB	0.0%
TOTAL: 7	699942	100.0%	64.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	597656	46.4%
Negative hits	587529	45.6%
Cache misses	63906	5.0%
Positive hits	40090	3.1%
TOTAL: 4	1289181	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.000	0.0%	40	0.000	0.000	0.000
article cleanup	00:00:10.516	0.0%	598425	0.000	0.018	1.000
article logging	00:00:10.763	0.0%	599246	0.000	0.018	0.333
article parse	00:00:23.433	0.0%	1883118	0.000	0.012	0.250
article write	00:04:20.298	0.3%	598056	0.000	0.435	4.138
artlog/artparse	00:00:00.003	0.0%	74	0.000	0.041	0.500
artlog/artwrite	00:00:00.001	0.0%	47	0.000	0.021	1.000
data move	00:00:06.255	0.0%	882894	0.000	0.007	0.161
hissync/artwrite	00:00:00.002	0.0%	1	2.000	2.000	2.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:18.308	0.0%	1290168	0.000	0.014	0.167
history sync	00:00:01.030	0.0%	691	0.000	1.491	18.000
history write	00:02:43.076	0.2%	598125	0.000	0.273	1.000
idle	23:41:54.673	98.8%	1991754	11.837	42.834	20250.667
nntp read	00:00:26.204	0.0%	1987824	0.000	0.013	0.375
overview write	00:01:46.203	0.1%	598009	0.000	0.178	8.250
perl filter	00:00:39.435	0.0%	598096	0.000	0.066	1.000
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:42.745	0.0%	611759	0.000	0.070	1.158
TOTAL: 23:58:32.713	23:53:42.945	99.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.000	0.0%	263	0.000	0.000	0.000
article prepare	00:00:00.000	0.0%	12	0.000	0.000	0.000
article read	00:00:00.072	0.0%	3	0.000	24.000	39.000
backlog stats	00:00:00.024	0.0%	4971	0.000	0.005	0.500
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.034	0.0%	598	0.000	0.057	3.000
data write	00:00:00.042	0.0%	328	0.000	0.128	2.000
idle	23:58:21.266	100.0%	4971	313.093	17360.947	30111.500
status file	00:00:00.039	0.0%	227	0.000	0.172	1.250
TOTAL: 23:58:22.290	23:58:21.477	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	43:54:04.388	99.9%	29176	8.500	5416.931	239533.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:13.975	0.0%	120091	0.000	0.116	38.786
readart	00:00:47.413	0.0%	20527	0.000	2.310	39.000
TOTAL: 43:57:58.808	43:55:05.776	99.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	292
flushlogs	2
go	2
logmode	2
lowmark	1
mode	151
name	2
pause	2
paused	2
reserve	2
shutdown	3
throttle	2
TOTAL: 12	463

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	localhost	100	675695	584929	90603	163	86%	21:47:08
2	cyber23-out.news.weretis.net	8	26978	13496	13153	329	50%	45:16:01
TOTAL: 2		108	702673	598425	103756	492	85%	67:03:09

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	localhost	2.3 GB	0.0 KB	3.6 MB	2.3 GB	99%	4.1 KB
2	cyber23-out.news.weretis.net	50.2 MB	1.2 MB	1.2 MB	52.6 MB	95%	3.9 KB
TOTAL: 2		2.3 GB	1.2 MB	4.8 MB	2.4 GB	99%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 4 03:00:00 - 03:59:59	24226	4.1%	6.73	129.9 MB	0.0%	36.96
Dec 4 04:00:00 - 04:59:59	21865	3.7%	6.07	177.3 MB	11.0%	50.44
Dec 4 05:00:00 - 05:59:59	21154	3.5%	5.88	77.4 MB	4.8%	22.03
Dec 4 06:00:00 - 06:59:59	19046	3.2%	5.29	54.3 MB	3.4%	15.44
Dec 4 07:00:00 - 07:59:59	22318	3.7%	6.20	94.9 MB	5.9%	26.98
Dec 4 08:00:00 - 08:59:59	20375	3.4%	5.66	102.7 MB	6.4%	29.23
Dec 4 09:00:00 - 09:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Dec 4 10:00:00 - 10:59:59	10265	1.7%	2.85	32.9 MB	2.0%	9.36
Dec 4 11:00:00 - 11:59:59	21354	3.6%	5.93	128.1 MB	7.9%	36.43
Dec 4 12:00:00 - 12:59:59	18950	3.2%	5.26	76.5 MB	4.7%	21.77
Dec 4 13:00:00 - 13:59:59	19182	3.2%	5.33	42.4 MB	2.6%	12.07
Dec 4 14:00:00 - 14:59:59	17448	2.9%	4.85	88.2 MB	5.5%	25.09
Dec 4 15:00:00 - 15:59:59	33691	5.6%	9.36	125.8 MB	7.8%	35.77
Dec 4 16:00:00 - 16:59:59	35616	6.0%	9.89	126.6 MB	7.8%	36.02
Dec 4 17:00:00 - 17:59:59	37360	6.2%	10.38	152.9 MB	9.5%	43.50
Dec 4 18:00:00 - 18:59:59	30002	5.0%	8.33	134.6 MB	8.3%	38.28
Dec 4 19:00:00 - 19:59:59	34465	5.8%	9.57	86.2 MB	5.3%	24.51
Dec 4 20:00:00 - 20:59:59	37660	6.3%	10.46	200.2 MB	12.4%	56.96
Dec 4 21:00:00 - 21:59:59	30479	5.1%	8.47	116.8 MB	7.2%	33.22
Dec 4 22:00:00 - 22:59:59	40563	6.8%	11.27	119.7 MB	7.4%	34.06
Dec 4 23:00:00 - 23:59:59	39036	6.5%	10.84	132.3 MB	8.2%	37.63
Dec 5 00:00:00 - 00:59:59	35507	5.9%	9.86	131.4 MB	8.1%	37.37
Dec 5 01:00:00 - 01:59:59	16943	2.8%	4.71	37.1 MB	2.3%	10.55
Dec 5 02:00:00 - 03:00:00	10495	1.8%	2.92	27.4 MB	1.7%	7.80
TOTAL: 24:00:00	598000	100.0%	6.92	1.6 GB	100.0%	19.15

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	localhost	745	4	0	40	701
2	cyber23-out.news.weretis.net	613	4	327	0	282
TOTAL: 2		1358	8	327	40	983

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it-alt.comp.software.mozilla	2
fr.petites-annonces.divers	2
de.soc.subkultur.bdsmSadomasochisten	1
cakewalk.audio	1
alt.religion	1
alt.math.undergrad	1
TOTAL: 6	8

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

Groups	Count
at.anzeigen.arbeitsmarkt	24
it.scienza.astronomia	4
fido7.spb.sex.adv	2
it.fan.starwars	2
at.anzeigen.kontakte	1
it.cultura.religioni.bahai	1
clari.news.issues	1
cuug.jobs	1
clari.hot.j	1
comp.lang.ml	1
fido7.ru.talk.english	1
clari.world.europe	1
TOTAL: 12	40

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	localhost	9
	TOTAL: 1	9
Including strange strings
	localhost	578
	cyber23-out.news.weretis.net	281
	TOTAL: 2	859
No colon-space in header
	localhost	1
	TOTAL: 1	1
TOTAL: 3		869

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	weretis.net	259	0	256	3	0	4	0%	07:42:26
TOTAL: 1		259	0	256	3	0	4	0%	07:42:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	weretis.net	0.0 KB	14.3 KB	14.3 KB	0.0 KB/s	4.8 KB	07:42:26
TOTAL: 1		0.0 KB	14.3 KB	14.3 KB	0.0 KB/s	4.8 KB	07:42:26

UUCP batches created:

Server	Offered	Articles	Size	Elapsed
news.quux.org	269	13495	48.9 MB	00:00:38
TOTAL: 1	269	13495	48.9 MB	00:00:38

Rnews articles offered from:

System	Offered
news.quux.org	17160
TOTAL: 1	17160

Rnews connections rejected:

Reason	Conn
400 Not a directory writing SMstore file -- throttling	3
TOTAL: 1	3

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	?	66	20523	1.1 GB	234	0	26:53:50
2	*.unhb.de	1442	3	11.5 KB	3	3	00:04:46
3	*.unity-media.net	40	1	7.6 KB	1	0	16:59:10
4	unresolved	1	0	0.0 KB	0	0	00:00:03
TOTAL: 4		1549	20527	1.1 GB	238	3	43:57:49

Curious NNRP server explorers [Top 20]:

System	Conn
185.220.101.183	1
TOTAL: 1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	de	20540	100.0%
2	unhb	5	0.0%
3	control	1	0.0%
4	junk	1	0.0%
TOTAL: 4		20547	100.0%

Daily Usenet report for news.cyber23.de

Dec 4 03:00:00 -- Dec 5 03:00:00