src/systemd-analyze

   1 #!/usr/bin/python
   2
   3 import dbus, sys
   4
   5 def acquire_time_data():
   6
   7         manager = dbus.Interface(bus.get_object('org.freedesktop.systemd1', '/org/freedesktop/systemd1'), 'org.freedesktop.systemd1.Manager')
   8         units = manager.ListUnits()
   9
  10         l = []
  11
  12         for i in units:
  13                 if i[5] != "":
  14                         continue
  15
  16                 properties = dbus.Interface(bus.get_object('org.freedesktop.systemd1', i[6]), 'org.freedesktop.DBus.Properties')
  17
  18                 ixt = int(properties.Get('org.freedesktop.systemd1.Unit', 'InactiveExitTimestampMonotonic'))
  19                 aet = int(properties.Get('org.freedesktop.systemd1.Unit', 'ActiveEnterTimestampMonotonic'))
  20                 axt = int(properties.Get('org.freedesktop.systemd1.Unit', 'ActiveExitTimestampMonotonic'))
  21                 iet = int(properties.Get('org.freedesktop.systemd1.Unit', 'InactiveEnterTimestampMonotonic'))
  22
  23                 l.append((str(i[0]), ixt, aet, axt, iet))
  24
  25         return l
  26
  27 def acquire_start_time():
  28         properties = dbus.Interface(bus.get_object('org.freedesktop.systemd1', '/org/freedesktop/systemd1'), 'org.freedesktop.DBus.Properties')
  29
  30         initrd_time = int(properties.Get('org.freedesktop.systemd1.Manager', 'InitRDTimestampMonotonic'))
  31         startup_time = int(properties.Get('org.freedesktop.systemd1.Manager', 'StartupTimestampMonotonic'))
  32         finish_time = int(properties.Get('org.freedesktop.systemd1.Manager', 'FinishTimestampMonotonic'))
  33
  34         assert initrd_time <= startup_time
  35         assert startup_time <= finish_time
  36
  37         return initrd_time, startup_time, finish_time
  38
  39 def draw_box(context, j, k, l, m, r = 0, g = 0, b = 0):
  40         context.save()
  41         context.set_source_rgb(r, g, b)
  42         context.rectangle(j, k, l, m)
  43         context.fill()
  44         context.restore()
  45
  46 def draw_text(context, x, y, text, size = 12, r = 0, g = 0, b = 0, vcenter = 0.5, hcenter = 0.5):
  47         context.save()
  48
  49         context.set_source_rgb(r, g, b)
  50         context.select_font_face("Sans", cairo.FONT_SLANT_NORMAL, cairo.FONT_WEIGHT_NORMAL)
  51         context.set_font_size(size)
  52
  53         if vcenter or hcenter:
  54                 x_bearing, y_bearing, width, height = context.text_extents(text)[:4]
  55
  56                 if hcenter:
  57                         x = x - width*hcenter - x_bearing
  58
  59                 if vcenter:
  60                         y = y - height*vcenter - y_bearing
  61
  62         context.move_to(x, y)
  63         context.show_text(text)
  64
  65         context.restore()
  66
  67 def help():
  68         sys.stdout.write("""systemd-analyze time
  69 systemd-analyze blame
  70 systemd-analyze plot
  71
  72 Process systemd profiling information
  73
  74   -h --help         Show this help
  75 """)
  76
  77
  78 bus = dbus.SystemBus()
  79
  80 if len(sys.argv) <= 1 or sys.argv[1] == 'time':
  81
  82         initrd_time, start_time, finish_time = acquire_start_time()
  83
  84         if initrd_time > 0:
  85                 print "Startup finished in %lums (kernel) + %lums (initramfs) + %lums (userspace) = %lums" % ( \
  86                         initrd_time/1000, \
  87                         (start_time - initrd_time)/1000, \
  88                         (finish_time - start_time)/1000, \
  89                         finish_time/1000)
  90         else:
  91                 print "Startup finished in %lums (kernel) + %lums (userspace) = %lums" % ( \
  92                         start_time/1000, \
  93                         (finish_time - start_time)/1000, \
  94                         finish_time/1000)
  95
  96
  97 elif sys.argv[1] == 'blame':
  98
  99         data = acquire_time_data()
 100         s = sorted(data, key = lambda i: i[2] - i[1], reverse = True)
 101
 102         for name, ixt, aet, axt, iet in s:
 103
 104                 if ixt <= 0 or aet <= 0:
 105                         continue
 106
 107                 if aet <= ixt:
 108                         continue
 109
 110                 sys.stdout.write("%6lums %s\n" % ((aet - ixt) / 1000, name))
 111
 112 elif sys.argv[1] == 'plot':
 113         import cairo, os
 114
 115         initrd_time, start_time, finish_time = acquire_start_time()
 116         data = acquire_time_data()
 117         s = sorted(data, key = lambda i: i[1])
 118
 119         # Account for kernel and initramfs bars if they exist
 120         if initrd_time > 0:
 121                 count = 3
 122         else:
 123                 count = 2
 124
 125         for name, ixt, aet, axt, iet in s:
 126
 127                 if (ixt >= start_time and ixt <= finish_time) or \
 128                                 (aet >= start_time and aet <= finish_time) or \
 129                                 (axt >= start_time and axt <= finish_time):
 130                         count += 1
 131
 132         border = 100
 133         bar_height = 20
 134         bar_space = bar_height * 0.1
 135
 136         # 1000px = 10s, 1px = 10ms
 137         width = finish_time/10000 + border*2
 138         height = count * (bar_height + bar_space) + border * 2
 139
 140         if width < 1000:
 141                 width = 1000
 142
 143         surface = cairo.SVGSurface(sys.stdout, width, height)
 144         context = cairo.Context(surface)
 145
 146         draw_box(context, 0, 0, width, height, 1, 1, 1)
 147
 148         context.translate(border + 0.5, border + 0.5)
 149
 150         context.save()
 151         context.set_line_width(1)
 152         context.set_source_rgb(0.7, 0.7, 0.7)
 153
 154         for x in range(0, finish_time/10000 + 100, 100):
 155                 context.move_to(x, 0)
 156                 context.line_to(x, height-border*2)
 157
 158         context.move_to(0, 0)
 159         context.line_to(width-border*2, 0)
 160
 161         context.move_to(0, height-border*2)
 162         context.line_to(width-border*2, height-border*2)
 163
 164         context.stroke()
 165         context.restore()
 166
 167         osrel = "Linux"
 168         if os.path.exists("/etc/os-release"):
 169                 for line in open("/etc/os-release"):
 170                         if line.startswith('PRETTY_NAME='):
 171                                 osrel = line[12:]
 172                                 osrel = osrel.strip('\"\n')
 173                                 break
 174
 175         banner = "{} {} ({} {}) {}".format(osrel, *(os.uname()[1:5]))
 176         draw_text(context, 0, -15, banner, hcenter = 0, vcenter = 1)
 177
 178         for x in range(0, finish_time/10000 + 100, 100):
 179                 draw_text(context, x, -5, "%lus" % (x/100), vcenter = 0, hcenter = 0)
 180
 181         y = 0
 182
 183         # draw boxes for kernel and initramfs boot time
 184         if initrd_time > 0:
 185                 draw_box(context, 0, y, initrd_time/10000, bar_height, 0.7, 0.7, 0.7)
 186                 draw_text(context, 10, y + bar_height/2, "kernel", hcenter = 0)
 187                 y += bar_height + bar_space
 188
 189                 draw_box(context, initrd_time/10000, y, start_time/10000-initrd_time/10000, bar_height, 0.7, 0.7, 0.7)
 190                 draw_text(context, initrd_time/10000 + 10, y + bar_height/2, "initramfs", hcenter = 0)
 191                 y += bar_height + bar_space
 192
 193         else:
 194                 draw_box(context, 0, y, start_time/10000, bar_height, 0.6, 0.6, 0.6)
 195                 draw_text(context, 10, y + bar_height/2, "kernel", hcenter = 0)
 196                 y += bar_height + bar_space
 197
 198         draw_box(context, start_time/10000, y, finish_time/10000-start_time/10000, bar_height, 0.7, 0.7, 0.7)
 199         draw_text(context, start_time/10000 + 10, y + bar_height/2, "userspace", hcenter = 0)
 200         y += bar_height + bar_space
 201
 202         for name, ixt, aet, axt, iet in s:
 203
 204                 drawn = False
 205                 left = -1
 206
 207                 if ixt >= start_time and ixt <= finish_time:
 208
 209                         # Activating
 210                         a = ixt
 211                         b = min(filter(lambda x: x >= ixt, (aet, axt, iet, finish_time))) - ixt
 212
 213                         draw_box(context, a/10000, y, b/10000, bar_height, 1, 0, 0)
 214                         drawn = True
 215
 216                         if left < 0:
 217                                 left = a
 218
 219                 if aet >= start_time and aet <= finish_time:
 220
 221                         # Active
 222                         a = aet
 223                         b = min(filter(lambda x: x >= aet, (axt, iet, finish_time))) - aet
 224
 225                         draw_box(context, a/10000, y, b/10000, bar_height, .8, .6, .6)
 226                         drawn = True
 227
 228                         if left < 0:
 229                                 left = a
 230
 231                 if axt >= start_time and axt <= finish_time:
 232
 233                         # Deactivating
 234                         a = axt
 235                         b = min(filter(lambda x: x >= axt, (iet, finish_time))) - axt
 236
 237                         draw_box(context, a/10000, y, b/10000, bar_height, .6, .4, .4)
 238                         drawn = True
 239
 240                         if left < 0:
 241                                 left = a
 242
 243                 if drawn:
 244                         x = left/10000
 245
 246                         if x < width/2-border:
 247                                 draw_text(context, x + 10, y + bar_height/2, name, hcenter = 0)
 248                         else:
 249                                 draw_text(context, x - 10, y + bar_height/2, name, hcenter = 1)
 250
 251                         y += bar_height + bar_space
 252
 253         draw_text(context, 0, height-border*2, "Legend: Red = Activating; Pink = Active; Dark Pink = Deactivating", hcenter = 0, vcenter = -1)
 254
 255         if initrd_time > 0:
 256                 draw_text(context, 0, height-border*2 + bar_height, "Startup finished in %lums (kernel) + %lums (initramfs) + %lums (userspace) = %lums" % ( \
 257                         initrd_time/1000, \
 258                         (start_time - initrd_time)/1000, \
 259                         (finish_time - start_time)/1000, \
 260                         finish_time/1000), hcenter = 0, vcenter = -1)
 261         else:
 262                 draw_text(context, 0, height-border*2 + bar_height, "Startup finished in %lums (kernel) + %lums (userspace) = %lums" % ( \
 263                         start_time/1000, \
 264                         (finish_time - start_time)/1000, \
 265                         finish_time/1000), hcenter = 0, vcenter = -1)
 266
 267         surface.finish()
 268 elif sys.argv[1] in ("help", "--help", "-h"):
 269         help()
 270 else:
 271         sys.stderr.write("Unknown verb '%s'.\n" % sys.argv[1])
 272         sys.exit(1)