fbs/fontandbitmapserver/utils/fbsbitmap_memory.pl
author hgs
Thu, 09 Sep 2010 10:13:45 +0300
changeset 171 414d4b727fd9
parent 160 969102054596
child 178 89bd4cfee505
child 186 1bc91eb0b8ae
permissions -rw-r--r--
201034
Ignore whitespace changes - Everywhere: Within whitespace: At end of lines:
160
hgs
parents:
diff changeset
     1
#!/usr/local/bin/perl
hgs
parents:
diff changeset
     2
#
hgs
parents:
diff changeset
     3
# Copyright (c) 2010 Nokia Corporation and/or its subsidiary(-ies).
hgs
parents:
diff changeset
     4
# All rights reserved.
hgs
parents:
diff changeset
     5
# This component and the accompanying materials are made available
hgs
parents:
diff changeset
     6
# under the terms of "Eclipse Public License v1.0"
hgs
parents:
diff changeset
     7
# which accompanies this distribution, and is available
hgs
parents:
diff changeset
     8
# at the URL "http://www.eclipse.org/legal/epl-v10.html".
hgs
parents:
diff changeset
     9
#
hgs
parents:
diff changeset
    10
# Initial Contributors:
hgs
parents:
diff changeset
    11
# Nokia Corporation - initial contribution.
hgs
parents:
diff changeset
    12
#
hgs
parents:
diff changeset
    13
# Contributors:
hgs
parents:
diff changeset
    14
#
hgs
parents:
diff changeset
    15
# Description:
hgs
parents:
diff changeset
    16
#  This script parses trace data produced by OST from FBS, using the the FBSCLI, 
hgs
parents:
diff changeset
    17
#  FBSERV and Symbian BTrace Hooks OST dictionaries, to produce a CSV output of
hgs
parents:
diff changeset
    18
#  the amount of bitmap memory used per-thread over a user-definable time
hgs
parents:
diff changeset
    19
#  granularity, since the start of the trace.
hgs
parents:
diff changeset
    20
# 
hgs
parents:
diff changeset
    21
#  To use, enable SYMBIAN_KERNEL_THREAD_IDENTIFICATION trace group in Symbian
hgs
parents:
diff changeset
    22
#  BTrace Hooks OST dictionary, GRAPHICS_RESOURCE_MANAGEMENT_SEMANTICS in FBSERV
hgs
parents:
diff changeset
    23
#  OST dictionary, and GRAPHICS_RESOURCE_MANAGEMENT_SEMANTICS, 
hgs
parents:
diff changeset
    24
#  GRAPHICS_RESOURCE_MANAGEMENT_FUNCTIONS and GRAPHICS_CONTROL_FUNCTIONS in
hgs
parents:
diff changeset
    25
#  FBSCLI OST dictionary. Once tracing is gathered, save trace output as ascii 
hgs
parents:
diff changeset
    26
#  and run this script against it. The resulting file can then be imported into
hgs
parents:
diff changeset
    27
#  a spreadsheet application to be visually processed.
hgs
parents:
diff changeset
    28
#  
hgs
parents:
diff changeset
    29
#  KNOWN DEFECTS:
hgs
parents:
diff changeset
    30
#  Once the log time goes beyond midnight, snapshots will stop being taken.
hgs
parents:
diff changeset
    31
#
hgs
parents:
diff changeset
    32
hgs
parents:
diff changeset
    33
use strict;
hgs
parents:
diff changeset
    34
hgs
parents:
diff changeset
    35
# Sanity checking of the command line parameters...
hgs
parents:
diff changeset
    36
if ($#ARGV == -1 || $ARGV[0] eq "help" || $ARGV[0] eq "/?")
hgs
parents:
diff changeset
    37
{
hgs
parents:
diff changeset
    38
   print "\nusage: $0 filename [-h]\n";
hgs
parents:
diff changeset
    39
   print "where\n";
hgs
parents:
diff changeset
    40
   print " -h : Specifies the heartbeat in millisecs (default=10000)\n";
hgs
parents:
diff changeset
    41
   exit;
hgs
parents:
diff changeset
    42
}
hgs
parents:
diff changeset
    43
hgs
parents:
diff changeset
    44
hgs
parents:
diff changeset
    45
## Modifiable constants...
hgs
parents:
diff changeset
    46
my $CSV_DELIMITER = ',';
hgs
parents:
diff changeset
    47
hgs
parents:
diff changeset
    48
# Time after start to take first snapshot, in millisecs
hgs
parents:
diff changeset
    49
my $firstHeartBeatTimeMS = 1000;
hgs
parents:
diff changeset
    50
hgs
parents:
diff changeset
    51
# Default heartbeat in millisecs if none specified.
hgs
parents:
diff changeset
    52
my $heartBeatMS = 10000;
hgs
parents:
diff changeset
    53
hgs
parents:
diff changeset
    54
hgs
parents:
diff changeset
    55
##
hgs
parents:
diff changeset
    56
## Internal structures...
hgs
parents:
diff changeset
    57
##
hgs
parents:
diff changeset
    58
my $heartBeatCount = 0;
hgs
parents:
diff changeset
    59
my $nextHeartBeatMS = -1;
hgs
parents:
diff changeset
    60
hgs
parents:
diff changeset
    61
# A hash of thread names to the amount of bitmap memory they 
hgs
parents:
diff changeset
    62
# have used since the start of the trace.
hgs
parents:
diff changeset
    63
my %bmpMemoryPerThread = ();
hgs
parents:
diff changeset
    64
hgs
parents:
diff changeset
    65
# A hash of bitmaps fully qualified by the session they belong to,
hgs
parents:
diff changeset
    66
# and their local handle (because bitmaps can have the same local
hgs
parents:
diff changeset
    67
# handle in different threads), mapped to their size in bytes.
hgs
parents:
diff changeset
    68
my %bmpMemoryByServerHandle = ();
hgs
parents:
diff changeset
    69
hgs
parents:
diff changeset
    70
# Hash of FbsSessions to thread IDs.
hgs
parents:
diff changeset
    71
my %SessionThreadMap = ();
hgs
parents:
diff changeset
    72
hgs
parents:
diff changeset
    73
# Array of the above hashes, one hash per heartbeat.
hgs
parents:
diff changeset
    74
my @arrayOfSnapshots;
hgs
parents:
diff changeset
    75
hgs
parents:
diff changeset
    76
# Hashes of thread and process names to IDs.
hgs
parents:
diff changeset
    77
my %ThreadNames;
hgs
parents:
diff changeset
    78
my %ProcessNames;
hgs
parents:
diff changeset
    79
hgs
parents:
diff changeset
    80
hgs
parents:
diff changeset
    81
##
hgs
parents:
diff changeset
    82
## Command line options parsing...
hgs
parents:
diff changeset
    83
## First arg is assumed to be the filename.
hgs
parents:
diff changeset
    84
##
hgs
parents:
diff changeset
    85
for my $i (1..$#ARGV)
hgs
parents:
diff changeset
    86
{
hgs
parents:
diff changeset
    87
   my $cma = $ARGV[$i];
hgs
parents:
diff changeset
    88
   if ($cma =~ m/-h(\d*)/)
hgs
parents:
diff changeset
    89
   {
hgs
parents:
diff changeset
    90
      $heartBeatMS = $1;
hgs
parents:
diff changeset
    91
   }
hgs
parents:
diff changeset
    92
   else
hgs
parents:
diff changeset
    93
   {
hgs
parents:
diff changeset
    94
      print "Unrecognised parameter: $cma , ignoring...\n";
hgs
parents:
diff changeset
    95
   }
hgs
parents:
diff changeset
    96
}
hgs
parents:
diff changeset
    97
hgs
parents:
diff changeset
    98
## Read from the file.
hgs
parents:
diff changeset
    99
## Read the log into an array line by line.
hgs
parents:
diff changeset
   100
my $TRACE_FILENAME = $ARGV[0];
hgs
parents:
diff changeset
   101
open(INPUT_FILE, $TRACE_FILENAME) or die $!;
hgs
parents:
diff changeset
   102
my @traceLines = <INPUT_FILE>;
hgs
parents:
diff changeset
   103
hgs
parents:
diff changeset
   104
hgs
parents:
diff changeset
   105
##
hgs
parents:
diff changeset
   106
## Parse each line sequentially...
hgs
parents:
diff changeset
   107
##
hgs
parents:
diff changeset
   108
foreach my $line (@traceLines)
hgs
parents:
diff changeset
   109
{
hgs
parents:
diff changeset
   110
   my $timeFromMidnightMS;
hgs
parents:
diff changeset
   111
hgs
parents:
diff changeset
   112
   ## 
hgs
parents:
diff changeset
   113
   ## If this line is about a new process, make a note of the name and the
hgs
parents:
diff changeset
   114
   ## associated process id, so that FbsSessions can be mapped to their 
hgs
parents:
diff changeset
   115
   ## thread by name.
hgs
parents:
diff changeset
   116
   ##
hgs
parents:
diff changeset
   117
   if ($line =~ /^.*Thread:Process name assigned;NThread:(.*);DProcess:(.*);Name:(.*)$/i)
hgs
parents:
diff changeset
   118
   {
hgs
parents:
diff changeset
   119
      my $threadId  = $1;
hgs
parents:
diff changeset
   120
      my $processId = $2;
hgs
parents:
diff changeset
   121
      my $processName = $3;
hgs
parents:
diff changeset
   122
      $ProcessNames{$processId} = $processName ;
hgs
parents:
diff changeset
   123
   }
hgs
parents:
diff changeset
   124
hgs
parents:
diff changeset
   125
   ## 
hgs
parents:
diff changeset
   126
   ## If this line is about a new process, make a note of the name and the
hgs
parents:
diff changeset
   127
   ## associated process id, so that FbsSessions can be mapped to their 
hgs
parents:
diff changeset
   128
   ## thread by name when the csv is generated.
hgs
parents:
diff changeset
   129
   ##
hgs
parents:
diff changeset
   130
   if (($line =~ /^.*Thread:Thread created;NThread:(.*);DProcess:(.*);Name:(.*)$/i) ||
hgs
parents:
diff changeset
   131
      ($line =~ /^.*Thread:Thread name assigned;NThread:(.*);DProcess:(.*);Name:(.*)$/i))
hgs
parents:
diff changeset
   132
      {
hgs
parents:
diff changeset
   133
      my $threadId  = $1;
hgs
parents:
diff changeset
   134
      my $processId = $2;
hgs
parents:
diff changeset
   135
      my $threadName = $3;
hgs
parents:
diff changeset
   136
      my $fullThreadName = $ProcessNames{$processId} . ":" . $threadName;
hgs
parents:
diff changeset
   137
      $ThreadNames{$threadId} = $fullThreadName;
hgs
parents:
diff changeset
   138
   }
hgs
parents:
diff changeset
   139
hgs
parents:
diff changeset
   140
   ##
hgs
parents:
diff changeset
   141
   ## Determine timestamp. If this time is beyond the heartbeat, 
hgs
parents:
diff changeset
   142
   ## take a snapshot and 
hgs
parents:
diff changeset
   143
   ##
hgs
parents:
diff changeset
   144
   if ($line =~ /^(\d\d):(\d\d):(\d\d)\.(\d{3})/)
hgs
parents:
diff changeset
   145
   {
hgs
parents:
diff changeset
   146
      $timeFromMidnightMS = ((($1 * 3600) + ($2 * 60) + $3) * 1000) + $4;
hgs
parents:
diff changeset
   147
      # Set up the time for the first snapshot.
hgs
parents:
diff changeset
   148
      if ($nextHeartBeatMS == -1) 
hgs
parents:
diff changeset
   149
      {
hgs
parents:
diff changeset
   150
         $nextHeartBeatMS = $timeFromMidnightMS + $firstHeartBeatTimeMS;
hgs
parents:
diff changeset
   151
      }
hgs
parents:
diff changeset
   152
   }
hgs
parents:
diff changeset
   153
hgs
parents:
diff changeset
   154
   ##
hgs
parents:
diff changeset
   155
   ## If heartbeat reached, take snapshot of bmp memory per thread
hgs
parents:
diff changeset
   156
   ## and set next heartbeat time.
hgs
parents:
diff changeset
   157
   ##
hgs
parents:
diff changeset
   158
   while ($timeFromMidnightMS >= $nextHeartBeatMS)
hgs
parents:
diff changeset
   159
   {
hgs
parents:
diff changeset
   160
      $nextHeartBeatMS += $heartBeatMS;
hgs
parents:
diff changeset
   161
      # take a snapshot of the current bitmap memory usage per thread
hgs
parents:
diff changeset
   162
      while ((my $thread, my $bmpMemory) = each(%bmpMemoryPerThread))
hgs
parents:
diff changeset
   163
      {
hgs
parents:
diff changeset
   164
           $arrayOfSnapshots[$heartBeatCount]{$thread} = $bmpMemory;
hgs
parents:
diff changeset
   165
      }
hgs
parents:
diff changeset
   166
      $heartBeatCount++;
hgs
parents:
diff changeset
   167
   }
hgs
parents:
diff changeset
   168
hgs
parents:
diff changeset
   169
   ## FBS Client-side traces.
hgs
parents:
diff changeset
   170
   if ($line =~ m/\tFBSCLI: /)
hgs
parents:
diff changeset
   171
   {
hgs
parents:
diff changeset
   172
      ##
hgs
parents:
diff changeset
   173
      ## If this line is an FBSCLI trace, and it contains iSSH then
hgs
parents:
diff changeset
   174
      ## it gives a chance to map a client thread ID to a session handle.
hgs
parents:
diff changeset
   175
      ## 
hgs
parents:
diff changeset
   176
      if ( $line =~ m/iSSH=(\w*);.*Thread ID:(.*)$/)
hgs
parents:
diff changeset
   177
      {
hgs
parents:
diff changeset
   178
         my $ServerSessionHandle = $1;
hgs
parents:
diff changeset
   179
         my $thread = $2;
hgs
parents:
diff changeset
   180
         if ($thread ne "0x00000000")
hgs
parents:
diff changeset
   181
         {
hgs
parents:
diff changeset
   182
            $SessionThreadMap{$ServerSessionHandle} = $thread;
hgs
parents:
diff changeset
   183
         }
hgs
parents:
diff changeset
   184
      }
hgs
parents:
diff changeset
   185
   }
hgs
parents:
diff changeset
   186
hgs
parents:
diff changeset
   187
   ## 
hgs
parents:
diff changeset
   188
   ## FBS Server-side traces.
hgs
parents:
diff changeset
   189
   ##
hgs
parents:
diff changeset
   190
   if ($line =~ m/\tFBSERV: /)
hgs
parents:
diff changeset
   191
   {
hgs
parents:
diff changeset
   192
      ## The line must have a s= parameter to be useful - the session server handle.
hgs
parents:
diff changeset
   193
      ## Any FBSERV line without this is not considered for parsing.
hgs
parents:
diff changeset
   194
      if ($line =~ m/; iSSH=(\w*);/)
hgs
parents:
diff changeset
   195
      {
hgs
parents:
diff changeset
   196
         my $FbsSessionHandle = $1;
hgs
parents:
diff changeset
   197
         my $thread = "Unknown Thread [Session=$FbsSessionHandle]";
hgs
parents:
diff changeset
   198
         if (defined($SessionThreadMap{$FbsSessionHandle}))
hgs
parents:
diff changeset
   199
         {
hgs
parents:
diff changeset
   200
            $thread = $SessionThreadMap{$FbsSessionHandle};
hgs
parents:
diff changeset
   201
         }
hgs
parents:
diff changeset
   202
         if ($line =~ m/# Server resource destroyed; .*iH=(\w*);/)
hgs
parents:
diff changeset
   203
         {
hgs
parents:
diff changeset
   204
            my $bmpHandle = $1;
hgs
parents:
diff changeset
   205
            my $bmpIdentifier = "$FbsSessionHandle:$bmpHandle";
hgs
parents:
diff changeset
   206
            if (defined($bmpMemoryByServerHandle{$bmpIdentifier}))
hgs
parents:
diff changeset
   207
            {
hgs
parents:
diff changeset
   208
               $bmpMemoryPerThread{$thread} -= $bmpMemoryByServerHandle{$bmpIdentifier};
hgs
parents:
diff changeset
   209
               delete $bmpMemoryByServerHandle{$bmpIdentifier};
hgs
parents:
diff changeset
   210
            }
hgs
parents:
diff changeset
   211
         }
hgs
parents:
diff changeset
   212
         if ($line =~ m/# Server bitmap resized; .*iOldH=(\w*); iNewH=(\w*); newbytes=(\d*);/)
hgs
parents:
diff changeset
   213
         {
hgs
parents:
diff changeset
   214
            # When a bitmap is resized, the amount of memory held by the bitmap may change
hgs
parents:
diff changeset
   215
            # and the bitmap localhandle will change.
hgs
parents:
diff changeset
   216
            my $oldBmpHandle = $1;
hgs
parents:
diff changeset
   217
            my $newBmpHandle = $2;
hgs
parents:
diff changeset
   218
            my $newBmpBytes = $3;
hgs
parents:
diff changeset
   219
            my $oldBmpIdentifier = "$FbsSessionHandle:$oldBmpHandle";
hgs
parents:
diff changeset
   220
            my $newBmpIdentifier = "$FbsSessionHandle:$newBmpHandle";
hgs
parents:
diff changeset
   221
            if (defined($bmpMemoryByServerHandle{$oldBmpIdentifier}))
hgs
parents:
diff changeset
   222
            {
hgs
parents:
diff changeset
   223
               $bmpMemoryPerThread{$thread} -= $bmpMemoryByServerHandle{$oldBmpIdentifier};
hgs
parents:
diff changeset
   224
               delete $bmpMemoryByServerHandle{$oldBmpIdentifier};
hgs
parents:
diff changeset
   225
            }
hgs
parents:
diff changeset
   226
            $bmpMemoryPerThread{$thread} += $newBmpBytes;
hgs
parents:
diff changeset
   227
            $bmpMemoryByServerHandle{$newBmpIdentifier} = $newBmpBytes;           
hgs
parents:
diff changeset
   228
         }
hgs
parents:
diff changeset
   229
         elsif ($line =~ m/#.*iOldH=(\w*); iNewH=(\w*);/)
hgs
parents:
diff changeset
   230
         {
hgs
parents:
diff changeset
   231
            # When a bitmap is compressed, cleaned or resized, the bitmap local handle changes
hgs
parents:
diff changeset
   232
            my $oldBmpHandle = $1;
hgs
parents:
diff changeset
   233
            my $newBmpHandle = $2;
hgs
parents:
diff changeset
   234
            my $oldBmpIdentifier = "$FbsSessionHandle:$oldBmpHandle";
hgs
parents:
diff changeset
   235
            my $newBmpIdentifier = "$FbsSessionHandle:$newBmpHandle";
hgs
parents:
diff changeset
   236
            if (defined($bmpMemoryByServerHandle{$oldBmpIdentifier}))
hgs
parents:
diff changeset
   237
            {
hgs
parents:
diff changeset
   238
               my $bytes = $bmpMemoryByServerHandle{$oldBmpIdentifier};
hgs
parents:
diff changeset
   239
               delete $bmpMemoryByServerHandle{$oldBmpIdentifier};
hgs
parents:
diff changeset
   240
               $bmpMemoryByServerHandle{$newBmpIdentifier} = $bytes;
hgs
parents:
diff changeset
   241
            }
hgs
parents:
diff changeset
   242
         }
hgs
parents:
diff changeset
   243
         elsif ($line =~ m/#.*iH=(\w*);.*bytes=(\d+);/)
hgs
parents:
diff changeset
   244
         {
hgs
parents:
diff changeset
   245
            # Duplication of a bitmap typically. When a bitmap is duplicated,
hgs
parents:
diff changeset
   246
            # the memory is 'owned' by all threads that duplicate it.
hgs
parents:
diff changeset
   247
            my $bmpHandle = $1;
hgs
parents:
diff changeset
   248
            my $bmpBytes = $2;
hgs
parents:
diff changeset
   249
            my $bmpIdentifier = "$FbsSessionHandle:$bmpHandle";
hgs
parents:
diff changeset
   250
            $bmpMemoryPerThread{$thread} += $bmpBytes;
hgs
parents:
diff changeset
   251
            $bmpMemoryByServerHandle{$bmpIdentifier} = $bmpBytes;
hgs
parents:
diff changeset
   252
         }
hgs
parents:
diff changeset
   253
      }
hgs
parents:
diff changeset
   254
   }
hgs
parents:
diff changeset
   255
}
hgs
parents:
diff changeset
   256
hgs
parents:
diff changeset
   257
close (INPUT_FILE);
hgs
parents:
diff changeset
   258
hgs
parents:
diff changeset
   259
hgs
parents:
diff changeset
   260
##
hgs
parents:
diff changeset
   261
## Make a map of unique threads across all snapshots
hgs
parents:
diff changeset
   262
## This is so only one occurrence of each thread will appear
hgs
parents:
diff changeset
   263
## in the csv file.
hgs
parents:
diff changeset
   264
##
hgs
parents:
diff changeset
   265
my %uniqueThreads = ();
hgs
parents:
diff changeset
   266
for my $i (0..$#arrayOfSnapshots)
hgs
parents:
diff changeset
   267
{
hgs
parents:
diff changeset
   268
   for my $thread (keys %{$arrayOfSnapshots[$i]})
hgs
parents:
diff changeset
   269
   {
hgs
parents:
diff changeset
   270
      $uniqueThreads{$thread} = 1;
hgs
parents:
diff changeset
   271
   }
hgs
parents:
diff changeset
   272
}
hgs
parents:
diff changeset
   273
hgs
parents:
diff changeset
   274
##
hgs
parents:
diff changeset
   275
## Start writing to file.
hgs
parents:
diff changeset
   276
## First row, which contains the heartbeat number column headings...
hgs
parents:
diff changeset
   277
##
hgs
parents:
diff changeset
   278
my $OUTPUT_FILENAME = sprintf("%s.csv", $TRACE_FILENAME);
hgs
parents:
diff changeset
   279
open(OUTPUT_FILE,">$OUTPUT_FILENAME") or die $!;
hgs
parents:
diff changeset
   280
print OUTPUT_FILE "Session$CSV_DELIMITER";
hgs
parents:
diff changeset
   281
for my $i (0..$heartBeatCount)
hgs
parents:
diff changeset
   282
{
hgs
parents:
diff changeset
   283
    print OUTPUT_FILE "$i$CSV_DELIMITER";
hgs
parents:
diff changeset
   284
}
hgs
parents:
diff changeset
   285
hgs
parents:
diff changeset
   286
##
hgs
parents:
diff changeset
   287
## For each subsequent row, print the first thread and the
hgs
parents:
diff changeset
   288
## memory at each snapshot...
hgs
parents:
diff changeset
   289
##
hgs
parents:
diff changeset
   290
print OUTPUT_FILE "\n";
hgs
parents:
diff changeset
   291
while ((my $thread, my $dummy) = each(%uniqueThreads))
hgs
parents:
diff changeset
   292
{
hgs
parents:
diff changeset
   293
    # Resolve the thread to its full name...
hgs
parents:
diff changeset
   294
    print OUTPUT_FILE "$thread";
hgs
parents:
diff changeset
   295
    if (defined($ThreadNames{$thread}) )
hgs
parents:
diff changeset
   296
    {
hgs
parents:
diff changeset
   297
       my $threadName = $ThreadNames{$thread};
hgs
parents:
diff changeset
   298
       print OUTPUT_FILE ":$threadName";
hgs
parents:
diff changeset
   299
    }
hgs
parents:
diff changeset
   300
    print OUTPUT_FILE "$CSV_DELIMITER";
hgs
parents:
diff changeset
   301
hgs
parents:
diff changeset
   302
    # print the memory use per thread, for each snapshot...
hgs
parents:
diff changeset
   303
    for my $i (0..$#arrayOfSnapshots)
hgs
parents:
diff changeset
   304
    {
hgs
parents:
diff changeset
   305
       my %snapshot = %{$arrayOfSnapshots[$i]};
hgs
parents:
diff changeset
   306
       while ((my $snapshotThread, my $bmpMemory) = each(%snapshot))
hgs
parents:
diff changeset
   307
       {
hgs
parents:
diff changeset
   308
           if ($snapshotThread eq $thread) 
hgs
parents:
diff changeset
   309
           {
hgs
parents:
diff changeset
   310
              print OUTPUT_FILE "$bmpMemory";
hgs
parents:
diff changeset
   311
           }
hgs
parents:
diff changeset
   312
       }
hgs
parents:
diff changeset
   313
       print OUTPUT_FILE "$CSV_DELIMITER";
hgs
parents:
diff changeset
   314
    }
hgs
parents:
diff changeset
   315
    print OUTPUT_FILE "\n";
hgs
parents:
diff changeset
   316
}
hgs
parents:
diff changeset
   317
close (OUTPUT_FILE);
hgs
parents:
diff changeset
   318