kodi 4.9.0-2-686-pae mem April 23 2017, 09:03:16 AM
Kernel Suspend Time: 354.726 ms
Kernel Resume Time: 778.993 ms
0000:00:01.0 {radeon}
0000:00:01.0 {radeon}
0000:00:01.0 {radeon}
-300ms
-200ms
-100ms
suspend
0000:00:01.0 {radeon}
0000:00:01.0 {radeon}
0000:00:01.0 {radeon}
resume
100ms
200ms
300ms
400ms
500ms
600ms
700ms
suspend prepare
suspend
suspend late
suspend noirq
suspend machine
resume machine
resume noirq
resume early
resume
resume complete
initcall_debug_start (0.000 ms @ 1182.232281)pm_dev_dbg (0.000 ms @ 1182.232283)strlen (0.000 ms @ 1182.232286)dev_driver_string (0.001 ms @ 1182.232289)dev_driver_string (0.000 ms @ 1182.232291)strlen (0.001 ms @ 1182.232293)strlen (0.000 ms @ 1182.232296)strlen (0.000 ms @ 1182.232298)pci_has_legacy_pm_support.isra.6 (0.000 ms @ 1182.232304)_cond_resched (0.000 ms @ 1182.232307)_raw_spin_lock_irqsave (0.000 ms @ 1182.232309)rpm_resume (0.000 ms @ 1182.232312)_raw_spin_unlock_irqrestore (0.000 ms @ 1182.232314)drm_kms_helper_poll_disable [drm_kms_helper] (0.004 ms @ 1182.232320)drm_modeset_lock_all [drm] (0.009 ms @ 1182.232326)drm_helper_connector_dpms [drm_kms_helper] (0.001 ms @ 1182.232338)drm_helper_connector_dpms [drm_kms_helper] (0.000 ms @ 1182.232340)drm_helper_connector_dpms [drm_kms_helper] (19.557 ms @ 1182.232343)drm_modeset_unlock_all [drm] (0.002 ms @ 1182.251904)radeon_fbdev_robj_is_fb [radeon] (0.001 ms @ 1182.251909)mutex_lock_interruptible (0.000 ms @ 1182.251912)ttm_bo_del_sub_from_lru [ttm] (0.001 ms @ 1182.251914)radeon_bo_unpin [radeon] (0.002 ms @ 1182.251917)_raw_spin_lock (0.000 ms @ 1182.251922)ttm_bo_add_to_lru [ttm] (0.001 ms @ 1182.251924)ww_mutex_unlock (0.000 ms @ 1182.251927)radeon_bo_evict_vram [radeon] (11.931 ms @ 1182.251929)radeon_fence_wait_empty [radeon] (0.002 ms @ 1182.263869)radeon_fence_wait_empty [radeon] (0.000 ms @ 1182.263874)radeon_fence_wait_empty [radeon] (0.001 ms @ 1182.263876)radeon_fence_wait_empty [radeon] (0.001 ms @ 1182.263878)radeon_fence_wait_empty [radeon] (0.000 ms @ 1182.263880)radeon_fence_wait_empty [radeon] (0.001 ms @ 1182.263882)radeon_fence_wait_empty [radeon] (0.000 ms @ 1182.263885)radeon_fence_wait_empty [radeon] (0.000 ms @ 1182.263887)radeon_save_bios_scratch_regs [radeon] (0.005 ms @ 1182.263889)evergreen_suspend [radeon] (8.119 ms @ 1182.263897)evergreen_hpd_fini [radeon] (0.011 ms @ 1182.272019)radeon_agp_suspend [radeon] (0.001 ms @ 1182.471147)pci_save_state (0.041 ms @ 1182.471149)pci_disable_device (0.004 ms @ 1182.471191)pci_set_power_state (17.871 ms @ 1182.471197)console_lock (0.001 ms @ 1182.489075)radeon_fbdev_set_suspend [radeon] (0.005 ms @ 1182.489077)console_unlock (0.001 ms @ 1182.489083)__suspend_report_result (0.000 ms @ 1182.489087)pci_do_fixups (0.001 ms @ 1182.489090)strlen (0.000 ms @ 1182.489094)dev_driver_string (0.000 ms @ 1182.489095)dev_driver_string (0.000 ms @ 1182.489097)strlen (0.001 ms @ 1182.489098)ktime_get (0.000 ms @ 1182.489103)initcall_debug_start (0.000 ms @ 1182.545652)pm_dev_dbg (0.000 ms @ 1182.545653)strlen (0.000 ms @ 1182.545654)dev_driver_string (0.000 ms @ 1182.545656)dev_driver_string (0.000 ms @ 1182.545657)strlen (0.000 ms @ 1182.545658)strlen (0.000 ms @ 1182.545659)strlen (0.000 ms @ 1182.545660)acpi_pci_power_manageable (0.000 ms @ 1182.545664)pci_bus_read_config_word (0.002 ms @ 1182.545666)pci_bus_write_config_word (0.002 ms @ 1182.545668)pci_bus_read_config_word (0.002 ms @ 1182.563547)acpi_pci_get_power_state (0.000 ms @ 1182.563552)pci_bus_read_dev_vendor_id (0.002 ms @ 1182.563553)pci_bus_read_config_word (0.002 ms @ 1182.563556)pcie_capability_write_word (0.002 ms @ 1182.563562)pcie_capability_write_word (0.000 ms @ 1182.563565)pcie_capability_write_word (0.000 ms @ 1182.563566)pcie_capability_write_word (0.000 ms @ 1182.563567)pcie_capability_write_word (0.003 ms @ 1182.563568)pcie_capability_write_word (0.002 ms @ 1182.563573)pcie_capability_write_word (0.000 ms @ 1182.563575)pci_restore_ats_state (0.000 ms @ 1182.563577)pci_restore_vc_state (0.008 ms @ 1182.563578)pci_cleanup_aer_error_status_regs (0.000 ms @ 1182.563587)pci_restore_config_dword (0.002 ms @ 1182.563588)pci_restore_config_dword (0.002 ms @ 1182.563591)pci_restore_config_dword (0.002 ms @ 1182.563594)pci_restore_config_dword (0.002 ms @ 1182.563597)pci_restore_config_dword (0.002 ms @ 1182.563600)pci_restore_config_dword (0.002 ms @ 1182.563603)pci_restore_config_dword (0.002 ms @ 1182.563606)pci_restore_config_dword (0.002 ms @ 1182.563609)pci_restore_config_dword (0.002 ms @ 1182.563612)pci_restore_config_dword (0.002 ms @ 1182.563615)pci_restore_config_dword (0.002 ms @ 1182.563618)pci_restore_config_dword (0.002 ms @ 1182.563621)pci_restore_config_dword (0.003 ms @ 1182.563625)pci_restore_config_dword (0.002 ms @ 1182.563628)pci_restore_config_dword (0.003 ms @ 1182.563631)pci_restore_config_dword (0.001 ms @ 1182.563635)pci_find_capability (0.007 ms @ 1182.563637)pci_restore_msi_state (0.014 ms @ 1182.563645)pci_restore_iov_state (0.000 ms @ 1182.563660)pci_do_fixups (0.001 ms @ 1182.563663)pci_has_legacy_pm_support.isra.6 (0.000 ms @ 1182.563665)strlen (0.000 ms @ 1182.563667)dev_driver_string (0.000 ms @ 1182.563668)dev_driver_string (0.000 ms @ 1182.563670)strlen (0.000 ms @ 1182.563671)ktime_get (0.000 ms @ 1182.563674)initcall_debug_start (0.000 ms @ 1182.588961)pm_dev_dbg (0.000 ms @ 1182.588962)strlen (0.000 ms @ 1182.588963)dev_driver_string (0.000 ms @ 1182.588964)dev_driver_string (0.000 ms @ 1182.588965)strlen (0.001 ms @ 1182.588966)strlen (0.000 ms @ 1182.588967)strlen (0.000 ms @ 1182.588968)pci_has_legacy_pm_support.isra.6 (0.000 ms @ 1182.588971)pci_do_fixups (0.000 ms @ 1182.588973)__pci_enable_wake (0.000 ms @ 1182.588975)radeon_is_px [radeon] (0.000 ms @ 1182.588977)console_lock (0.001 ms @ 1182.588980)pci_set_power_state (0.000 ms @ 1182.588981)pci_restore_state (0.000 ms @ 1182.588983)pci_enable_device (0.005 ms @ 1182.588984)radeon_agp_resume [radeon] (0.000 ms @ 1182.588990)radeon_pm_late_init [radeon] (0.108 ms @ 1183.238921)radeon_restore_bios_scratch_regs [radeon] (0.001 ms @ 1183.239032)radeon_atom_encoder_init [radeon] (0.033 ms @ 1183.239034)radeon_atom_disp_eng_pll_init [radeon] (0.035 ms @ 1183.239069)evergreen_hpd_init [radeon] (0.017 ms @ 1183.239105)drm_helper_resume_force_mode [drm_kms_helper] (50.932 ms @ 1183.239124)drm_modeset_lock_all [drm] (0.004 ms @ 1183.290063)drm_helper_connector_dpms [drm_kms_helper] (0.000 ms @ 1183.290068)drm_helper_connector_dpms [drm_kms_helper] (0.000 ms @ 1183.290069)drm_helper_connector_dpms [drm_kms_helper] (0.065 ms @ 1183.290070)drm_modeset_unlock_all [drm] (0.001 ms @ 1183.290137)drm_kms_helper_poll_enable [drm_kms_helper] (0.002 ms @ 1183.290139)radeon_pm_compute_clocks [radeon] (0.001 ms @ 1183.290142)radeon_fbdev_set_suspend [radeon] (0.014 ms @ 1183.290144)console_unlock (0.001 ms @ 1183.290159)strlen (0.000 ms @ 1183.290164)dev_driver_string (0.000 ms @ 1183.290165)dev_driver_string (0.000 ms @ 1183.290166)strlen (0.001 ms @ 1183.290167)ktime_get (0.000 ms @ 1183.290172)
Output files:
suspend-kodi-170423-090309-cg/kodi_mem_dmesg.txt
suspend-kodi-170423-090309-cg/kodi_mem_ftrace.txt
suspend-kodi-170423-090309-cg/kodi_mem.html
Analyzing the ftrace data...
Callgraph found for task 5919: 16.045ms, sys_sync
Callgraph found for task 5919: 0.010ms, pm_prepare_console
Callgraph found for task 5919: 4.364ms, freeze_processes
Callgraph found for task 5919: 3.811ms, freeze_kernel_threads
Callgraph found for task 5919: 0.001ms, pm_restrict_gfp_mask
Callgraph found for task 5919: 0.053ms, acpi_suspend_begin
Callgraph found for task 5919: 0.023ms, suspend_console
Callgraph found for task 5919: 0.571ms, acpi_pm_prepare
Callgraph found for task 5919: 3.838ms, _cpu_down
Callgraph found for task 5919: 0.449ms, syscore_suspend
Callgraph found for task 5919: 1.106ms, syscore_resume
Callgraph found for task 5919: 4.420ms, _cpu_up
Callgraph found for task 5919: 0.562ms, arch_enable_nonboot_cpus_end
Callgraph found for task 5919: 0.647ms, acpi_pm_finish
Callgraph found for task 5919: 0.019ms, resume_console
Callgraph found for task 5919: 0.087ms, acpi_pm_end
Callgraph found for task 5919: 0.000ms, pm_restore_gfp_mask
Callgraph found for task 5919: 2.950ms, thaw_processes
Callgraph found for task 5919: 0.210ms, pm_notifier_call_chain
Callgraph found for task 5919: 0.005ms, pm_restore_console
Timeline Details:
test start: 1182.183701
kernel suspend start: 1182.183809
suspend_prepare: 1182.183809 - 1182.221830 (1 devices)
suspend: 1182.221830 - 1182.489185 (1 devices)
suspend_late: 1182.489185 - 1182.491055 (0 devices)
suspend_noirq: 1182.491055 - 1182.533169 (1 devices)
suspend_machine: 1182.533169 - 1182.538535 (0 devices)
resume_machine: 1182.538535 - 1182.545417 (0 devices)
resume_noirq: 1182.545417 - 1182.583410 (1 devices)
resume_early: 1182.583410 - 1182.584427 (0 devices)
resume: 1182.584427 - 1183.290497 (1 devices)
resume_complete: 1183.290497 - 1183.317528 (1 devices)
kernel resume end: 1183.317528
test end: 1183.317528
Analyzing the dmesg data...
Creating Device Timeline...