[Bug 105622] i915_init takes over 100 ms

Tue Mar 20 12:26:26 UTC 2018

https://bugs.freedesktop.org/show_bug.cgi?id=105622

--- Comment #5 from Paul Menzel <pmenzel+bugs.freedesktop at molgen.mpg.de> ---
(In reply to Chris Wilson from comment #4)
> Nah, the time disappeared even before we were running:

I agree, that even the 2.3 seconds before are quite long too. But that is
mainly due to `populate_rootfs` and the time to execute the initramfs, for
example the systemd-bootchart SVG attached to [1].

> [    2.331714] calling  i915_init+0x0/0x59 [i915] @ 294
> [    2.331715] proc_thermal 0000:00:04.0: enabling device (0000 -> 0002)
> [    2.331965] calling  alsa_hwdep_init+0x0/0x1000 [snd_hwdep] @ 289
> [    2.331969] initcall alsa_hwdep_init+0x0/0x1000 [snd_hwdep] returned 0
> after 2 usecs
> [    2.333214] calling  btusb_driver_init+0x0/0x1000 [btusb] @ 301
> [    2.333452] usbcore: registered new interface driver btusb
> [    2.333456] initcall btusb_driver_init+0x0/0x1000 [btusb] returned 0
> after 232 usecs
> [    2.335541] calling  hda_bus_init+0x0/0x11 [snd_hda_core] @ 289
> [    2.335554] initcall hda_bus_init+0x0/0x11 [snd_hda_core] returned 0
> after 7 usecs
> [    2.337340] Bluetooth: hci0: using rampatch file:
> qca/rampatch_usb_00000302.bin
> [    2.337341] Bluetooth: hci0: QCA: patch rome 0x302 build 0x138, firmware
> rome 0x302 build 0x111
> [    2.338045] calling  iTCO_vendor_init_module+0x0/0x1000
> [iTCO_vendor_support] @ 280
> [    2.338046] iTCO_vendor_support: vendor-support=0
> [    2.338048] initcall iTCO_vendor_init_module+0x0/0x1000
> [iTCO_vendor_support] returned 0 after 0 usecs
> [    2.338094] calling  uvc_init+0x0/0x1000 [uvcvideo] @ 295
> [    2.338569] calling  iTCO_wdt_init_module+0x0/0x1000 [iTCO_wdt] @ 280
> [    2.338570] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11
> [    2.338713] iTCO_wdt: Found a Intel PCH TCO device (Version=4,
> TCOBASE=0x0400)
> [    2.338755] uvcvideo: Found UVC 1.00 device Integrated_Webcam_HD
> (0bda:58f4)
> [    2.338827] iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
> [    2.338851] initcall iTCO_wdt_init_module+0x0/0x1000 [iTCO_wdt] returned
> 0 after 271 usecs
> [    2.340669] uvcvideo 1-5:1.0: Entity type for entity Extension 4 was not
> initialized!
> [    2.340670] uvcvideo 1-5:1.0: Entity type for entity Extension 7 was not
> initialized!
> [    2.340672] uvcvideo 1-5:1.0: Entity type for entity Processing 2 was not
> initialized!
> [    2.340673] uvcvideo 1-5:1.0: Entity type for entity Camera 1 was not
> initialized!
> [    2.340736] input: Integrated_Webcam_HD: Integrate as
> /devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.0/input/input9
> [    2.341447] uvcvideo: Unknown video format
> 00000032-0002-0010-8000-00aa00389b71
> [    2.341450] uvcvideo: Found UVC 1.00 device Integrated_Webcam_HD
> (0bda:58f4)
> [    2.343371] uvcvideo: Unable to create debugfs 1-2 directory.
> [    2.343420] uvcvideo 1-5:1.2: Entity type for entity Extension 10 was not
> initialized!
> [    2.343422] uvcvideo 1-5:1.2: Entity type for entity Extension 12 was not
> initialized!
> [    2.343423] uvcvideo 1-5:1.2: Entity type for entity Processing 9 was not
> initialized!
> [    2.343424] uvcvideo 1-5:1.2: Entity type for entity Camera 11 was not
> initialized!
> [    2.343472] input: Integrated_Webcam_HD: Integrate as
> /devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.2/input/input10
> [    2.343496] usbcore: registered new interface driver uvcvideo
> [    2.343496] USB Video Class driver (1.1.1)
> [    2.343501] initcall uvc_init+0x0/0x1000 [uvcvideo] returned 0 after 5275
> usecs
> [    2.368025] Bluetooth: hci0: using NVM file: qca/nvm_usb_00000302.bin
> [    2.368132] calling  ath10k_pci_init+0x0/0x1000 [ath10k_pci] @ 297
> [    2.368417] ath10k_pci 0000:02:00.0: enabling device (0000 -> 0002)
> [    2.369278] calling  serio_raw_drv_init+0x0/0x1000 [serio_raw] @ 280
> [    2.369288] initcall serio_raw_drv_init+0x0/0x1000 [serio_raw] returned 0
> after 8 usecs
> [    2.370528] calling  init_module+0x0/0xf10 [efivars] @ 283
> [    2.370529] EFI Variables Facility v0.08 2004-May-17
> [    2.370540] calling  init_fat_fs+0x0/0xfcb [fat] @ 327
> [    2.370665] initcall init_fat_fs+0x0/0xfcb [fat] returned 0 after 118
> usecs
> [    2.371435] ath10k_pci 0000:02:00.0: pci irq msi oper_irq_mode 2 irq_mode
> 0 reset_mode 0
> [    2.373899] calling  pcspkr_platform_driver_init+0x0/0x1000 [pcspkr] @ 295
> [    2.374266] input: PC Speaker as /devices/platform/pcspkr/input/input11
> [    2.374594] initcall pcspkr_platform_driver_init+0x0/0x1000 [pcspkr]
> returned 0 after 675 usecs
> [    2.377394] calling  init_vfat_fs+0x0/0x1000 [vfat] @ 327
> [    2.377399] initcall init_vfat_fs+0x0/0x1000 [vfat] returned 0 after 1
> usecs
> [    2.383102] calling  azx_driver_init+0x0/0xfd8 [snd_hda_intel] @ 289
> [    2.383159] calling  joydev_init+0x0/0x1000 [joydev] @ 282
> [    2.383498] initcall joydev_init+0x0/0x1000 [joydev] returned 0 after 323
> usecs
> [    2.384594] calling  pcsp_init+0x0/0x1000 [snd_pcsp] @ 295
> [    2.384597] Error: Driver 'pcspkr' is already registered, aborting...
> [    2.384930] initcall pcsp_init+0x0/0x1000 [snd_pcsp] returned -16 after
> 324 usecs
> [    2.394061] mei_me 0000:00:16.0: enabling device (0000 -> 0002)
> [    2.395838] initcall proc_thermal_init+0x0/0x1000
> [processor_thermal_device] returned 0 after 176806 usecs
> [    2.397894] calling  evdev_init+0x0/0x1000 [evdev] @ 301
> [    2.402423] initcall init_module+0x0/0xf10 [efivars] returned 0 after
> 31143 usecs
> [    2.402573] initcall evdev_init+0x0/0x1000 [evdev] returned 0 after 4565
> usecs
> [    2.402828] calling  init_nls_cp437+0x0/0x1000 [nls_cp437] @ 333
> [    2.402830] initcall init_nls_cp437+0x0/0x1000 [nls_cp437] returned 0
> after 0 usecs
> [    2.402955] calling  efivars_pstore_init+0x0/0x1000 [efi_pstore] @ 283
> [    2.402956] pstore: using zlib compression
> [    2.402963] pstore: Registered efi as persistent store backend
> [    2.402965] initcall efivars_pstore_init+0x0/0x1000 [efi_pstore] returned
> 0 after 7 usecs
> [    2.403948] calling  init_nls_ascii+0x0/0x1000 [nls_ascii] @ 335
> [    2.403950] initcall init_nls_ascii+0x0/0x1000 [nls_ascii] returned 0
> after 0 usecs
> [    2.409437] [drm:i915_driver_load [i915]] Found SunrisePoint LP PCH
> 
> 70ms before we did the initial pci checks.

Sorry, I do not understand the comment. So, it’s just a resource problem with
the other modules?

[1] https://gitlab.gnome.org/GNOME/gnome-shell/issues/126

-- 
You are receiving this mail because:
You are the assignee for the bug.
You are on the CC list for the bug.
You are the QA Contact for the bug.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.freedesktop.org/archives/intel-gfx-bugs/attachments/20180320/193d3b18/attachment-0001.html>