Daily Usenet report

Oct 22 05:00:10 -- Oct 23 04:45:32

Unknown entries from news log file:

First 18 / 18 lines (100.0%)
Oct 22 09:31:16 elvis innfeed[24005]: CNFS-sm: Mismatch 3: read BUF095 for cycbuff BUF094
Oct 22 09:31:16 elvis innfeed[24005]: SM storage method 'cnfs' failed initialization
Oct 22 09:31:17 elvis innfeed[24005]: SM one or more storage methods failed initialization
Oct 22 09:31:17 elvis innfeed[24005]: Storage manager initialization failed
Oct 22 09:31:29 elvis innd: CNFS-sm: Mismatch 3: read BUF095 for cycbuff BUF094
Oct 22 09:31:29 elvis innd: SM storage method 'cnfs' failed initialization
Oct 22 09:31:30 elvis innd: SM one or more storage methods failed initialization
Oct 22 09:32:48 elvis innfeed[25302]: CNFS-sm: No magic cookie found for cycbuff BUF094, initializing
Oct 22 09:32:48 elvis innfeed[25302]: CNFS-sm: CNFSflushhead: write failed (-1 bytes): Bad file descriptor
Oct 22 09:32:48 elvis innfeed[25302]: SM storage method 'cnfs' failed initialization
Oct 22 09:32:49 elvis innfeed[25302]: SM one or more storage methods failed initialization
Oct 22 09:32:49 elvis innfeed[25302]: Storage manager initialization failed
Oct 22 09:33:01 elvis innd: CNFS-sm: No magic cookie found for cycbuff BUF094, initializing
Oct 22 09:33:01 elvis innd: CNFS-sm: No magic cookie found for cycbuff BUF093, initializing
Oct 22 09:33:01 elvis innd: CNFS-sm: No magic cookie found for cycbuff BUF092, initializing
Oct 22 09:33:03 elvis innd: filter: Restored EMP database.
Oct 22 09:50:07 elvis innd: CNFS-sm: cnfs_retrieve: token @03054255463030340000003905CD00000001@: bogus cycbuff name: BUF004:0x720b9a00:1
Oct 22 11:47:10 elvis innd: CNFS-sm: metacycbuff MALT cycbuff is moved to BUF095 remain calm

Log entries by program:

Program nameLines%LinesSize%Size
inn 138912 68.4%15.9 MB 68.1%
innd 50388 24.8%5.5 MB 23.6%
nnrpd 6506 3.2%596.0 KB 2.5%
cnfsstat 3994 2.0%1019.9 KB 4.3%
batcher 1740 0.9%203.3 KB 0.9%
innfeed 1409 0.7%171.2 KB 0.7%
controlchan 18 0.0%1.3 KB 0.0%
rnews 3 0.0%0.3 KB 0.0%
TOTAL: 8 202970 100.0%23.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 161813 43.7%
Do not exist 141393 38.2%
Positive hits 47247 12.8%
Cache misses 19746 5.3%
TOTAL: 4 370199 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.774 0.0%3307 0.000 1.141 51.067
article control00:00:02.519 0.0%3237 0.000 0.778 42.000
article link00:00:00.000 0.0%0 0.000 0.000 0.000
article write00:06:50.114 0.5%109376 0.000 3.750 166.500
history grep00:00:00.520 0.0%555 0.000 0.937 16.333
history lookup00:06:34.268 0.5%370192 0.000 1.065 11.000
history sync00:00:01.338 0.0%15546 0.000 0.086 209.000
history write00:13:06.734 0.9%138307 0.000 5.688 61.167
idle22:47:44.318 96.3%1906611 0.000 43.042175877.000
overview write00:09:04.072 0.6%109376 0.000 4.974 123.667
perl filter00:11:07.470 0.8%138097 1.000 4.833 231.000
site send00:00:21.674 0.0%229274 0.000 0.095 5.250
TOTAL: 23:40:24.95823:34:56.801 99.6%----

Control commands to INND:

CommandNumber
flush 2061
flushlogs 1
paused 1
TOTAL: 3 2063

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1nntp.noris.net 8 52250 30868 12036 9346 59%04:15:00
2newsfeed1.freenet.de 374 32983 17515 13760 1708 53%16:55:24
3newsfeed0.freenet.de 392 20337 11898 7343 1096 58%16:51:58
4news.nl.linux.org 11 8273 4472 3714 87 54%17:15:39
5localhost 8 8 8 0 0 100%00:00:02
6finalfrontier.franken.de 231 0 0 0 0 0%00:00:04
TOTAL: 6 1029 113851 64761 36853 12237 56%55:18:07

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 22 09:00:10 - 09:59:59 3929 3.6% 1.0911.6 MB 0.7% 3.31
Oct 22 10:00:00 - 10:59:59 28142 25.7% 7.82185.1 MB 10.9% 52.64
Oct 22 11:00:00 - 11:59:59 28865 26.4% 8.02477.9 MB 28.2% 135.95
Oct 22 12:00:00 - 12:59:59 6860 6.3% 1.91543.0 MB 32.0% 154.45
Oct 22 13:00:00 - 13:59:59 1976 1.8% 0.557.6 MB 0.4% 2.15
Oct 22 14:00:00 - 14:59:59 2325 2.1% 0.6520.2 MB 1.2% 5.75
Oct 22 15:00:00 - 15:59:59 2565 2.3% 0.719.8 MB 0.6% 2.80
Oct 22 16:00:00 - 16:59:59 3028 2.8% 0.8416.9 MB 1.0% 4.81
Oct 22 17:00:00 - 17:59:59 3180 2.9% 0.8810.4 MB 0.6% 2.96
Oct 22 18:00:00 - 18:59:59 3467 3.2% 0.96108.5 MB 6.4% 30.86
Oct 22 19:00:00 - 19:59:59 3039 2.8% 0.8410.6 MB 0.6% 3.02
Oct 22 20:00:00 - 20:59:59 2982 2.7% 0.838.9 MB 0.5% 2.54
Oct 22 21:00:00 - 21:59:59 2886 2.6% 0.8061.5 MB 3.6% 17.50
Oct 22 22:00:00 - 22:59:59 2749 2.5% 0.7682.8 MB 4.9% 23.54
Oct 22 23:00:00 - 23:59:59 2793 2.6% 0.7815.1 MB 0.9% 4.29
Oct 23 00:00:00 - 00:59:59 2548 2.3% 0.7118.1 MB 1.1% 5.15
Oct 23 01:00:00 - 01:59:59 2303 2.1% 0.646.7 MB 0.4% 1.90
Oct 23 02:00:00 - 02:59:59 2335 2.1% 0.6582.3 MB 4.9% 23.42
Oct 23 03:00:00 - 03:59:59 1879 1.7% 0.5211.3 MB 0.7% 3.22
Oct 23 04:00:00 - 04:45:32 1528 1.4% 0.567.4 MB 0.4% 2.78
TOTAL: 19:45:22 109379 100.0% 1.541.7 GB 100.0% 24.42

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
BUF001MDEU1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF002MDEU1.9 GB21.1 MB 1.1% 1 0.31 74.31
BUF003MDEU1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF004MDEU1.9 GB1.9 GB 97.1% 0 0.00 0.00
BUF005MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF010MSUP1.9 GB491.5 KB 0.0% 2 0.00 0.00
BUF021MBIN1.9 GB491.5 KB 0.0% 22 0.00 0.00
BUF025MBIN1.9 GB491.5 KB 0.0% 23 0.00 0.00
BUF050MALL1.9 GB572.1 MB 29.3% 1 0.00 0.00
BUF051MBIN1.9 GB491.5 KB 0.0% 2 0.00 0.00
BUF052MALL1.9 GB111.6 MB 5.7% 1 1.65 14.05
BUF053MALT1.9 GB491.5 KB 0.0% 2 0.00 0.00
BUF054MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF055MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF056MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF057MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF058MALL1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF062MALL1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF063MALT1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF064MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF065MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF070MBIN1.9 GB491.5 KB 0.0% 3 0.00 0.00
BUF085MBIN1.9 GB1.8 GB 93.2% 0 0.00 0.00
BUF086MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF088MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF089MDEU1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF092MBIN1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF093MBIN1.9 GB491.5 KB 0.0% 0 0.00 0.00
BUF094MBIN1.9 GB313.7 MB 16.1% 0 12.42 1.86
BUF095MALT1.9 GB491.5 KB 0.0% 2 25.70 0.90
BUF096MALT1.9 GB491.5 KB 0.0% 2 0.00 0.00
BUF097MALT1.9 GB491.5 KB 0.0% 1 0.00 0.00
BUF098MALT1.9 GB995.6 MB 51.0% 1 16.64 1.39
BUF099MSUP1.9 GB307.1 MB 15.7% 0 0.98 23.64
BUFCTLMCTL500.0 MB203.9 MB 40.8% 11 0.00 0.00
BUFNOCMNOC500.0 MB33.0 MB 6.6% 0 0.15 39.41
TOTAL: 36-65.8 GB6.1 GB 9.3% 81 5.10-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.noris.net 25941 1832 0 5 14 0 0 024090
2newsfeed1.freenet.de 1919 32 0 18 1 0 0 0 1868
3newsfeed0.freenet.de 1203 37 0 14 0 0 0 0 1152
4news-out.odn.de 383 0 0 0 0 0 0 0 383
5news.nl.linux.org 87 1 0 38 0 0 0 0 48
TOTAL: 5 29533 1902 0 75 15 0 0 027541

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.sex.telephone.ads 302
alt.sex.marketplace 153
alt.sex.phone.ads 140
alt.sex.erotica.market.place 105
alt.binaries.nospam.breasts.natural 92
alt.sex.pictures.nospam 85
alt.sex.telephone 82
alt.sex.erotica.marketplace 64
misc.phone.mobile.iphone 63
novell.support.identity-manager.engine-drivers 57
alt.sex.femdom 56
alt.penthouse.sex.telephone 46
novell.support.identity-manager.userapp-workflow 31
comp.sys.laptops.thinkpad 26
comp.lang.xharbour 21
novell.support.groupwise.7x.clients 21
novell.support.bordermanager.proxies 20
novell.support.zenworks.configuration-management.10.server-install 19
alt.sex.fetish.feet 18
sci.physics.foundations 17
TOTAL: 163 1902

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

GroupsCount
alt.bigfoot.research 6
alt.christnet.religion 5
de.alt.fan.tabak 2
gnu.emacs.bug 1
gnu.bash.bug 1
TOTAL: 5 15

INND perl filter [Top 20]:

ReasonCount
EMP (md5) 10478
EMP (phl) 6159
Binary in non-binary group 4375
Poison newsgroup 2784
Cancel for rejected article 1343
Scoring filter (8) 382
EMP (fsl) 342
Scoring filter (9) 232
Scoring filter (10) 179
PFM bot misc 109
Scoring filter (11) 98
Scoring filter (12) 72
HTML post 62
Scoring filter (13) 40
Adult group ECP 31
Scoring filter (14) 25
Excessively crossposted test article 22
Scoring filter (16) 22
Scoring filter (15) 18
Attached HTML file 9
TOTAL: 27 26805

INND too many connects per minute:

SystemConn
news-out.odn.de 184
newsfeed0.freenet.de 57
newsfeed1.freenet.de 56
TOTAL: 3 297

INND misc events:

EventsCount
gethostbyname error 14
TOTAL: 1 14

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed0.freenet.de 1
TOTAL: 1 1
Huge articles
nntp.noris.net 170
TOTAL: 1 170
Including strange strings
nntp.noris.net 145
newsfeed0.freenet.de 43
newsfeed1.freenet.de 40
news-out.odn.de 1
TOTAL: 4 229
TOTAL: 3 400

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1newsserver.news.garr.it 247113 404 223382 191 1 13 0%140:27:41
2news-in.odn.de 3097 126 2971 0 0 0 4%126:19:23
3nntp.noris.net 5189 10 5173 0 0 17 0%128:13:45
4newsfeed.freenet.de 1365 2 1356 7 0 5 0%125:49:16
5hammer.uoregon.edu 0 0 0 0 0 174 0%146:39:30
6mail2news 0 0 0 0 0 33926 0%146:39:22
7news.hometree.net 0 0 0 0 0 7 0%146:29:23
8news.nl.linux.org 0 0 0 0 0 0 0%121:29:41
9fu-berlin.de 0 0 0 0 0 0 0%121:29:41
TOTAL: 9 256764 542 232882 198 1 34142 0%1203:37:42

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1newsserver.news.garr.it2.4 MB792.9 KB3.2 MB0.0 KB/s5.4 KB140:27:41
2news-in.odn.de544.6 KB0.0 KB544.6 KB0.0 KB/s4.3 KB126:19:23
3nntp.noris.net21.0 KB0.0 KB21.0 KB0.0 KB/s2.1 KB128:13:45
4newsfeed.freenet.de5.2 KB11.8 KB17.0 KB0.0 KB/s1.9 KB125:49:16
5hammer.uoregon.edu0.0 KB0.0 KB0.0 KB0.0 KB/s0146:39:30
6mail2news0.0 KB0.0 KB0.0 KB0.0 KB/s0146:39:22
7news.hometree.net0.0 KB0.0 KB0.0 KB0.0 KB/s0146:29:23
8news.nl.linux.org0.0 KB0.0 KB0.0 KB0.0 KB/s0121:29:41
9fu-berlin.de0.0 KB0.0 KB0.0 KB0.0 KB/s0121:29:41
TOTAL: 92.9 MB804.7 KB3.7 MB0.0 KB/s5.2 KB1203:37:42

UUCP batches created:

ServerOfferedArticlesSizeElapsed
aquanews 77 9662.0 MB00:01:19
billix 8 375875.7 KB00:00:05
chi 8 8261.6 MB00:00:04
classic 6 89258.8 KB00:00:03
crei 57 224459.8 KB00:00:57
gjbsd 1 46.0 KB00:00:01
hektor 5 39205.3 KB00:00:03
karnickel 209 1344640.3 MB00:02:24
kaschber 51 162347.9 KB00:00:24
knilch 6 232775.5 KB00:00:05
mbsks 70 226513.6 KB00:00:55
memotech 6 42104.6 KB00:00:05
moldy 2 612.4 KB00:00:04
polaris 3 346.6 KB00:00:01
sammy 133 396712.0 MB00:01:33
schul1 1 12.6 KB00:00:00
silesia 119 207510.7 MB00:01:26
solid 17 26936.9 MB00:00:09
swzcomm 6 241538.0 KB00:00:03
teebox 31 34688.6 MB00:00:31
tmb 6 1019.7 KB00:00:03
tychen 97 4671.2 MB00:01:39
unicorn 26 227458.6 KB00:00:13
watari 6 4401.1 MB00:00:04
TOTAL: 24 951 3022988.9 MB00:12:21

Rnews articles offered from:

SystemOffered
aquanews 1
TOTAL: 1 1

Rnews connections rejected:

ReasonConn
400 Input/output error writing SMstore file -- throttling 2
TOTAL: 1 2

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
177-20-163-116-dynip.superkabel.de 20 7801.6 MB 336 5 000:01:26
2r072d.r.pppool.de 33 5641.1 MB 177 1 004:03:41
3213.185.132.10 68 378834.7 KB 1484 0 000:04:37
4p54943efa.dip.t-dialin.net 6 343776.3 KB 84 1 000:00:41
5e181108186.adsl.alicedsl.de 7 36115.0 KB 60 0 000:00:53
6r24c3.r.pppool.de 5 3062.4 KB 16 0 000:47:12
7dslb-088-067-203-246.pools.arcor-ip.net 1 2672.5 KB 12 0 000:05:05
8r30e5.r.pppool.de 2 2551.7 KB 12 0 000:12:34
9ip-91-214-10-183.4msp.de 8 2032.6 KB 17 0 000:38:14
10e181109072.adsl.alicedsl.de 21 1535.4 KB 150 0 000:02:29
11ppp-93-104-155-66.dynamic.mnet-online.de 1 141.6 MB 2 0 000:02:48
12finalfrontier.franken.de 231 817.7 KB 8 0 000:00:15
13dsl01.83.171.156.137.ip-pool.nefkom.net 1 318.3 KB 6 0 000:00:25
TOTAL: 13 404 22426.2 MB 2364 7 0697897:15:52

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.superkabel.de 20 7801.6 MB 336 5 000:01:26
2*.r.pppool.de 40 6191.2 MB 205 1 005:03:28
3unresolved 68 378834.7 KB 1484 0 000:04:37
4*.dip.t-dialin.net 6 343776.3 KB 84 1 000:00:41
5*.adsl.alicedsl.de 28 51150.3 KB 210 0 000:03:22
6*.pools.arcor-ip.net 1 2672.5 KB 12 0 000:05:05
7*.4msp.de 8 2032.6 KB 17 0 000:38:14
8*.dynamic.mnet-online.de 1 141.6 MB 2 0 000:02:48
9*.franken.de 233 817.7 KB 8 0 000:00:25
10*.83.171.156.137.ip-pool.nefkom.net 1 318.3 KB 6 0 000:00:25
11*.versanet.de 3 00.0 KB 0 0 000:09:07
12*.com 1 00.0 KB 0 0 000:00:03
13*.central.biz.rr.com 3 00.0 KB 0 0 000:02:03
14*.dsl.klmzmi.ameritech.net 3 00.0 KB 0 0 000:00:02
15*.83.171.175.24.ip-pool.nefkom.net 1 00.0 KB 0 0 000:00:06
16*.83.171.144.211.ip-pool.nefkom.net 1 00.0 KB 0 0 000:00:39
17*.83.171.172.184.ip-pool.nefkom.net 22 00.0 KB 0 0 003:20:54
18*.83.171.182.193.ip-pool.nefkom.net 1 00.0 KB 0 0 000:26:27
19*.dip0.t-ipconnect.de 2 00.0 KB 0 0 000:29:42
20*.83.171.191.148.ip-pool.nefkom.net 24 00.0 KB 0 0 000:00:00
TOTAL: 20 467 22426.2 MB 2364 7 0697897:15:54

Curious NNRP server explorers [Top 20]:

SystemConn
dsl01.83.171.191.148.ip-pool.nefkom.net 24
dsl01.83.171.172.184.ip-pool.nefkom.net 22
i59f5c895.versanet.de 3
ppp-69-221-237-48.dsl.klmzmi.ameritech.net 3
rrcs-96-11-228-247.central.biz.rr.com 3
p54a39511.dip0.t-ipconnect.de 2
aquarius.franken.de 2
dsl01.83.171.144.211.ip-pool.nefkom.net 1
jammed.com 1
dsl01.83.171.175.24.ip-pool.nefkom.net 1
dsl01.83.171.182.193.ip-pool.nefkom.net 1
TOTAL: 11 63

NNRP no permission clients:

SystemConn
ip-92-50-108-188.unitymediagroup.de 3
TOTAL: 1 3

NNRP gethostbyaddr failures [Top 20]:

SystemConn
213.185.132.10 68
TOTAL: 1 68

NNRP client timeouts [Top 20]:

SystemConnPeer
r072d.r.pppool.de 2 0
r24c3.r.pppool.de 1 0
TOTAL: 2 3 0

Newsgroup request counts (by category):

CategoryCountPct
1de 1977 88.2%
2comp 202 9.0%
3ger 32 1.4%
4alt 14 0.6%
5rec 14 0.6%
6z-netz 3 0.1%
TOTAL: 6 2242100.0%

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

NewsgroupCount
1de.soc.recht.misc 460
2de.alt.sysadmin.recovery 303
3de.rec.fahrrad 160
4comp.lang.javascript 150
5de.comp.sys.mac.misc 121
6de.rec.motorrad 117
7de.alt.fan.aldi 109
8de.rec.heimwerken 82
9de.comp.lang.javascript 72
10de.etc.fahrzeug.auto 60
11de.etc.beruf.selbstaendig 55
12comp.lang.ruby 51
13de.alt.fan.tabak 49
14de.soc.recht.strafrecht 46
15de.comp.lang.php.misc 46
16de.rec.mampf 42
17de.comm.infosystems.www.authoring.misc 38
18de.sci.medizin.misc 34
19ger.ct 32
20de.soc.recht.strassenverkehr 27
21de.test 27
22de.alt.netdigest 20
23alt.fan.prettyboy 14
24de.comp.sys.mac.lokale-netze 12
25de.comp.lang.php.datenbanken 10
26de.rec.sport.laufen.misc 10
27rec.games.bridge 8
28de.markt.comp.hardware.laufwerke 8
29de.etc.sprache.deutsch 7
30de.rec.film.misc 6
31de.comp.sys.mac.internet 6
32de.comp.datenbanken.mysql 6
33de.rec.tv.lindenstrasse 6
34de.comp.hardware.laufwerke.festplatten 5
35de.rec.tiere.aquaristik 5
36de.markt.comp.hardware.cpu+mainboard 4
37de.alt.fan.haraldschmidt 4
38z-netz.alt.rechnerkrieg 3
39rec.sport.soccer 3
40de.soc.verkehr 3
41de.alt.mud 3
42rec.games.go 3
43de.markt.comp.hardware.graphik 3
44de.sci.medizin.diabetes 2
45de.comp.sys.mac.soc 2
46de.admin.net-abuse.mail 2
47de.rec.sport.laufen.trainingswoche 2
48de.rec.buecher 2
49comp.sys.mac.programmer.help 1
50de.comm.technik.isdn 1
TOTAL: 50 2242

innreport 3.0.2 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>.