[ 123.894400] gem_mmap_gtt: executing [ 123.919036] gem_mmap_gtt: starting subtest basic-copy [ 125.041475] gem_mmap_gtt: exiting, ret=0 [ 125.266053] gem_exec_basic: executing [ 125.281902] gem_exec_basic: starting subtest readonly-bsd1 [ 125.282510] gem_exec_basic: exiting, ret=0 [ 125.505106] drv_hangman: executing [ 125.505916] drv_hangman: starting subtest error-state-basic [ 131.795919] [drm] stuck on render ring [ 131.808553] [drm] GPU HANG: ecode 8:0:0xe75ffffe, in drv_hangman [5985], reason: Engine(s) hung, action: reset [ 131.808589] [drm] GPU hangs can indicate a bug anywhere in the entire gfx stack, including userspace. [ 131.808596] [drm] Please file a _new_ bug report on bugs.freedesktop.org against DRI -> DRM/Intel [ 131.808602] [drm] drm/i915 developers can then reassign to the right component if it's not a kernel issue. [ 131.808608] [drm] The gpu crash dump is required to analyze gpu hangs, so please always attach it. [ 131.808614] [drm] GPU crash dump saved to /sys/class/drm/card0/error [ 131.819460] drm/i915: Resetting chip after gpu hang [ 131.828316] drv_hangman: exiting, ret=0 [ 132.047351] prime_self_import: executing [ 132.048496] prime_self_import: starting subtest basic-llseek-size [ 132.066178] prime_self_import: exiting, ret=0 [ 132.287797] core_auth: executing [ 132.289865] core_auth: starting subtest basic-auth [ 132.292426] core_auth: exiting, ret=0 [ 132.519077] kms_pipe_crc_basic: executing [ 132.555497] kms_pipe_crc_basic: starting subtest suspend-read-crc-pipe-A [ 132.734041] PM: Syncing filesystems ... done. [ 132.751624] Freezing user space processes ... (elapsed 0.003 seconds) done. [ 132.755240] Freezing remaining freezable tasks ... (elapsed 0.002 seconds) done. [ 132.758372] Suspending console(s) (use no_console_suspend to debug) [ 132.768157] sd 0:0:0:0: [sda] Synchronizing SCSI cache [ 132.780482] sd 0:0:0:0: [sda] Stopping disk [ 132.889902] PM: suspend of devices complete after 129.133 msecs [ 132.924359] PM: late suspend of devices complete after 34.440 msecs [ 132.932433] r8169 0000:03:00.0: System wakeup enabled by ACPI [ 132.938105] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI [ 132.948029] PM: noirq suspend of devices complete after 23.660 msecs [ 132.948073] ACPI: Preparing to enter system sleep state S3 [ 132.960567] PM: Saving platform NVS memory [ 132.960803] Disabling non-boot CPUs ... [ 132.999863] Broke affinity for irq 116 [ 133.002229] smpboot: CPU 1 is now offline [ 133.022915] ====================================================== [ 133.022916] [ INFO: possible circular locking dependency detected ] [ 133.022921] 4.5.0-gfxbench-Patchwork_315+ #1 Tainted: G U [ 133.022922] ------------------------------------------------------- [ 133.022925] rtcwake/5998 is trying to acquire lock: [ 133.022942] (s_active#6){++++.+}, at: [] kernfs_remove_by_name_ns+0x40/0x90 [ 133.022943] but task is already holding lock: [ 133.022953] (cpu_hotplug.lock){+.+.+.}, at: [] cpu_hotplug_begin+0x6d/0xc0 [ 133.022954] which lock already depends on the new lock. [ 133.022955] the existing dependency chain (in reverse order) is: [ 133.022962] -> #3 (cpu_hotplug.lock){+.+.+.}: [ 133.022968] [] lock_acquire+0xb1/0x200 [ 133.022974] [] mutex_lock_nested+0x62/0x3c0 [ 133.022978] [] get_online_cpus+0x61/0x80 [ 133.022983] [] stop_machine+0x1b/0xe0 [ 133.023046] [] gen8_ggtt_insert_entries__BKL+0x2d/0x30 [i915] [ 133.023096] [] ggtt_bind_vma+0x46/0x70 [i915] [ 133.023146] [] i915_vma_bind+0xed/0x260 [i915] [ 133.023197] [] i915_gem_object_do_pin+0x873/0xb20 [i915] [ 133.023248] [] i915_gem_object_pin+0x28/0x30 [i915] [ 133.023301] [] intel_init_pipe_control+0xb5/0x200 [i915] [ 133.023354] [] intel_logical_rings_init+0x14e/0x1080 [i915] [ 133.023405] [] i915_gem_init+0xf3/0x130 [i915] [ 133.023462] [] i915_driver_load+0xbeb/0x1950 [i915] [ 133.023470] [] drm_dev_register+0xa4/0xb0 [ 133.023474] [] drm_get_pci_dev+0xce/0x1d0 [ 133.023519] [] i915_pci_probe+0x2f/0x50 [i915] [ 133.023525] [] pci_device_probe+0x85/0xf0 [ 133.023530] [] driver_probe_device+0x227/0x440 [ 133.023534] [] __driver_attach+0x83/0x90 [ 133.023538] [] bus_for_each_dev+0x61/0xa0 [ 133.023542] [] driver_attach+0x19/0x20 [ 133.023546] [] bus_add_driver+0x1e9/0x280 [ 133.023550] [] driver_register+0x5b/0xd0 [ 133.023555] [] __pci_register_driver+0x5b/0x60 [ 133.023559] [] drm_pci_init+0xd6/0x100 [ 133.023563] [] 0xffffffffa0230092 [ 133.023571] [] do_one_initcall+0xa6/0x1d0 [ 133.023577] [] do_init_module+0x5a/0x1c8 [ 133.023585] [] load_module+0x1efd/0x25a0 [ 133.023591] [] SyS_finit_module+0x98/0xc0 [ 133.023598] [] entry_SYSCALL_64_fastpath+0x16/0x6f [ 133.023603] -> #2 (&dev->struct_mutex){+.+.+.}: [ 133.023608] [] lock_acquire+0xb1/0x200 [ 133.023616] [] drm_gem_mmap+0x19f/0x2a0 [ 133.023622] [] mmap_region+0x389/0x5f0 [ 133.023626] [] do_mmap+0x36a/0x420 [ 133.023632] [] vm_mmap_pgoff+0x6d/0xa0 [ 133.023638] [] SyS_mmap_pgoff+0x183/0x220 [ 133.023645] [] SyS_mmap+0x16/0x20 [ 133.023649] [] entry_SYSCALL_64_fastpath+0x16/0x6f [ 133.023656] -> #1 (&mm->mmap_sem){++++++}: [ 133.023661] [] lock_acquire+0xb1/0x200 [ 133.023667] [] __might_fault+0x75/0xa0 [ 133.023673] [] kernfs_fop_write+0x8a/0x180 [ 133.023679] [] __vfs_write+0x23/0xe0 [ 133.023684] [] vfs_write+0xa2/0x190 [ 133.023687] [] SyS_write+0x44/0xb0 [ 133.023691] [] entry_SYSCALL_64_fastpath+0x16/0x6f [ 133.023697] -> #0 (s_active#6){++++.+}: [ 133.023701] [] __lock_acquire+0x1e81/0x1ef0 [ 133.023705] [] lock_acquire+0xb1/0x200 [ 133.023709] [] __kernfs_remove+0x241/0x320 [ 133.023713] [] kernfs_remove_by_name_ns+0x40/0x90 [ 133.023717] [] sysfs_remove_file_ns+0x10/0x20 [ 133.023722] [] device_del+0x124/0x240 [ 133.023726] [] device_unregister+0x19/0x60 [ 133.023731] [] cpu_cache_sysfs_exit+0x52/0xb0 [ 133.023735] [] cacheinfo_cpu_callback+0x38/0x70 [ 133.023739] [] notifier_call_chain+0x39/0xa0 [ 133.023743] [] __raw_notifier_call_chain+0x9/0x10 [ 133.023748] [] cpu_notify_nofail+0x1e/0x30 [ 133.023751] [] _cpu_down+0x200/0x330 [ 133.023756] [] disable_nonboot_cpus+0xaa/0x3b0 [ 133.023761] [] suspend_devices_and_enter+0x478/0xc30 [ 133.023765] [] pm_suspend+0x515/0x9e0 [ 133.023771] [] state_store+0x77/0xe0 [ 133.023777] [] kobj_attr_store+0xf/0x20 [ 133.023781] [] sysfs_kf_write+0x40/0x50 [ 133.023785] [] kernfs_fop_write+0x13c/0x180 [ 133.023790] [] __vfs_write+0x23/0xe0 [ 133.023794] [] vfs_write+0xa2/0x190 [ 133.023798] [] SyS_write+0x44/0xb0 [ 133.023802] [] entry_SYSCALL_64_fastpath+0x16/0x6f [ 133.023805] other info that might help us debug this: [ 133.023813] Chain exists of: s_active#6 --> &dev->struct_mutex --> cpu_hotplug.lock [ 133.023814] Possible unsafe locking scenario: [ 133.023815] CPU0 CPU1 [ 133.023816] ---- ---- [ 133.023819] lock(cpu_hotplug.lock); [ 133.023823] lock(&dev->struct_mutex); [ 133.023826] lock(cpu_hotplug.lock); [ 133.023830] lock(s_active#6); [ 133.023831] *** DEADLOCK *** [ 133.023835] 8 locks held by rtcwake/5998: [ 133.023847] #0: (sb_writers#6){.+.+.+}, at: [] __sb_start_write+0xb2/0xf0 [ 133.023855] #1: (&of->mutex){+.+.+.}, at: [] kernfs_fop_write+0x61/0x180 [ 133.023863] #2: (s_active#105){.+.+.+}, at: [] kernfs_fop_write+0x69/0x180 [ 133.023871] #3: (pm_mutex){+.+...}, at: [] pm_suspend+0x6f/0x9e0 [ 133.023882] #4: (acpi_scan_lock){+.+.+.}, at: [] acpi_scan_lock_acquire+0x12/0x14 [ 133.023891] #5: (cpu_add_remove_lock){+.+.+.}, at: [] disable_nonboot_cpus+0x24/0x3b0 [ 133.023899] #6: (cpu_hotplug.dep_map){++++++}, at: [] cpu_hotplug_begin+0x0/0xc0 [ 133.023906] #7: (cpu_hotplug.lock){+.+.+.}, at: [] cpu_hotplug_begin+0x6d/0xc0 [ 133.023907] stack backtrace: [ 133.023913] CPU: 0 PID: 5998 Comm: rtcwake Tainted: G U 4.5.0-gfxbench-Patchwork_315+ #1 [ 133.023915] Hardware name: /NUC5CPYB, BIOS PYBSWCEL.86A.0043.2015.0904.1904 09/04/2015 [ 133.023922] 0000000000000000 ffff880274967870 ffffffff81401d15 ffffffff825c52d0 [ 133.023927] ffffffff82586bd0 ffff8802749678b0 ffffffff810ca1b0 ffff880274967900 [ 133.023932] ffff880273845328 ffff880273844b00 ffff880273845440 0000000000000008 [ 133.023935] Call Trace: [ 133.023941] [] dump_stack+0x67/0x92 [ 133.023946] [] print_circular_bug+0x1e0/0x2e0 [ 133.023949] [] __lock_acquire+0x1e81/0x1ef0 [ 133.023953] [] lock_acquire+0xb1/0x200 [ 133.023959] [] ? kernfs_remove_by_name_ns+0x40/0x90 [ 133.023962] [] __kernfs_remove+0x241/0x320 [ 133.023965] [] ? kernfs_remove_by_name_ns+0x40/0x90 [ 133.023969] [] ? kernfs_find_ns+0x97/0x140 [ 133.023972] [] kernfs_remove_by_name_ns+0x40/0x90 [ 133.023975] [] sysfs_remove_file_ns+0x10/0x20 [ 133.023979] [] device_del+0x124/0x240 [ 133.023982] [] ? trace_hardirqs_on+0xd/0x10 [ 133.023986] [] device_unregister+0x19/0x60 [ 133.023989] [] cpu_cache_sysfs_exit+0x52/0xb0 [ 133.023992] [] cacheinfo_cpu_callback+0x38/0x70 [ 133.023995] [] notifier_call_chain+0x39/0xa0 [ 133.023999] [] __raw_notifier_call_chain+0x9/0x10 [ 133.024002] [] cpu_notify_nofail+0x1e/0x30 [ 133.024005] [] _cpu_down+0x200/0x330 [ 133.024011] [] ? __call_rcu.constprop.58+0x2f0/0x2f0 [ 133.024014] [] ? call_rcu_bh+0x20/0x20 [ 133.024019] [] ? trace_raw_output_rcu_utilization+0x60/0x60 [ 133.024023] [] ? trace_raw_output_rcu_utilization+0x60/0x60 [ 133.024027] [] disable_nonboot_cpus+0xaa/0x3b0 [ 133.024031] [] suspend_devices_and_enter+0x478/0xc30 [ 133.024035] [] pm_suspend+0x515/0x9e0 [ 133.024038] [] state_store+0x77/0xe0 [ 133.024043] [] kobj_attr_store+0xf/0x20 [ 133.024046] [] sysfs_kf_write+0x40/0x50 [ 133.024049] [] kernfs_fop_write+0x13c/0x180 [ 133.024054] [] __vfs_write+0x23/0xe0 [ 133.024059] [] ? percpu_down_read+0x52/0x90 [ 133.024062] [] ? __sb_start_write+0xb2/0xf0 [ 133.024065] [] ? __sb_start_write+0xb2/0xf0 [ 133.024069] [] vfs_write+0xa2/0x190 [ 133.024073] [] ? __fget_light+0x6a/0x90 [ 133.024076] [] SyS_write+0x44/0xb0 [ 133.024080] [] entry_SYSCALL_64_fastpath+0x16/0x6f [ 133.027055] ACPI: Low-level resume complete [ 133.027294] PM: Restoring platform NVS memory [ 133.028014] Enabling non-boot CPUs ... [ 133.028489] x86: Booting SMP configuration: [ 133.028492] smpboot: Booting Node 0 Processor 1 APIC 0x4 [ 133.033498] cache: parent cpu1 should not be sleeping [ 133.041857] CPU1 is up [ 133.042764] ACPI: Waking up from system sleep state S3 [ 133.069715] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI [ 133.084511] PM: noirq resume of devices complete after 16.376 msecs [ 134.141894] PM: early resume of devices complete after 1057.320 msecs [ 134.148704] r8169 0000:03:00.0: System wakeup disabled by ACPI [ 134.160952] r8169 0000:03:00.0 eth0: link down [ 134.167673] sd 0:0:0:0: [sda] Starting disk [ 134.454787] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) [ 134.454824] ata2: SATA link down (SStatus 4 SControl 300) [ 134.472282] ata1.00: configured for UDMA/133 [ 134.610164] PM: resume of devices complete after 468.257 msecs [ 134.611460] Restarting tasks ... done. [ 134.624610] kms_pipe_crc_basic: exiting, ret=0 [ 134.968414] Console: switching to colour dummy device 80x25 [ 135.303916] [drm] Module unloaded [ 135.429477] Setting dangerous option enable_psr - tainting kernel [ 135.480001] [drm] Memory usable by graphics device = 2048M [ 135.480069] [drm] Replacing VGA console driver [ 135.481121] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). [ 135.481136] [drm] Driver supports precise vblank timestamp query. [ 135.792069] ACPI: Video Device [GFX0] (multi-head: yes rom: no post: no) [ 135.798253] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input14 [ 135.809037] [drm] Initialized i915 1.6.0 20160314 for 0000:00:02.0 on minor 0 [ 135.906514] fbcon: inteldrmfb (fb0) is primary device [ 136.306076] Console: switching to colour frame buffer device 240x67 [ 136.327532] i915 0000:00:02.0: fb0: inteldrmfb frame buffer device [ 136.357152] snd_hda_intel 0000:00:1b.0: bound 0000:00:02.0 (ops i915_audio_component_bind_ops [i915]) [ 136.394377] snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC283: line_outs=2 (0x1b/0x21/0x0/0x0/0x0) type:hp [ 136.394496] snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 136.394577] snd_hda_codec_realtek hdaudioC0D0: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 136.394652] snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 [ 136.394716] snd_hda_codec_realtek hdaudioC0D0: dig-out=0x1e/0x0 [ 136.394778] snd_hda_codec_realtek hdaudioC0D0: inputs: [ 136.394833] snd_hda_codec_realtek hdaudioC0D0: Mic=0x19 [ 136.403726] gem_exec_store: executing [ 136.419697] gem_exec_store: starting subtest basic-default [ 136.420691] gem_exec_store: starting subtest basic-render [ 136.421613] gem_exec_store: starting subtest basic-bsd [ 136.423642] gem_exec_store: starting subtest basic-bsd1 [ 136.424134] gem_exec_store: starting subtest basic-bsd2 [ 136.425266] gem_exec_store: starting subtest basic-blt [ 136.428355] gem_exec_store: starting subtest basic-vebox [ 136.431170] gem_exec_store: exiting, ret=0 [ 136.475636] Console: switching to colour dummy device 80x25 [ 137.528264] r8169 0000:03:00.0 eth0: link up [ 140.539108] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input15 [ 140.542652] input: HDA Intel PCH Headphone Front as /devices/pci0000:00/0000:00:1b.0/sound/card0/input16 [ 140.545963] input: HDA Intel PCH Front Headphone Surround as /devices/pci0000:00/0000:00:1b.0/sound/card0/input17 [ 140.552367] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input18 [ 140.906536] [drm] Module unloaded [ 141.026235] Setting dangerous option enable_psr - tainting kernel [ 141.026257] Setting dangerous option inject_load_failure - tainting kernel [ 141.059270] [drm] Injecting failure at checkpoint 1 [i915_driver_init_early:1017] [ 141.111109] snd_hda_intel 0000:00:1b.0: failed to add i915 component master (-19) [ 141.123162] snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC283: line_outs=2 (0x1b/0x21/0x0/0x0/0x0) type:hp [ 141.123187] snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 141.123202] snd_hda_codec_realtek hdaudioC0D0: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 141.123216] snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 [ 141.123227] snd_hda_codec_realtek hdaudioC0D0: dig-out=0x1e/0x0 [ 141.123237] snd_hda_codec_realtek hdaudioC0D0: inputs: [ 141.123248] snd_hda_codec_realtek hdaudioC0D0: Mic=0x19 [ 141.217621] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input19 [ 141.227853] input: HDA Intel PCH Headphone Front as /devices/pci0000:00/0000:00:1b.0/sound/card0/input20 [ 141.237295] input: HDA Intel PCH Front Headphone Surround as /devices/pci0000:00/0000:00:1b.0/sound/card0/input21 [ 141.240092] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input22 [ 141.362300] [drm] Module unloaded [ 141.467043] Setting dangerous option enable_psr - tainting kernel [ 141.467065] Setting dangerous option inject_load_failure - tainting kernel [ 141.516855] [drm] Injecting failure at checkpoint 2 [i915_driver_init_mmio:1132] [ 141.568905] snd_hda_intel 0000:00:1b.0: failed to add i915 component master (-19) [ 141.585968] snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC283: line_outs=2 (0x1b/0x21/0x0/0x0/0x0) type:hp [ 141.585994] snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 141.586010] snd_hda_codec_realtek hdaudioC0D0: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 141.586024] snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 [ 141.586035] snd_hda_codec_realtek hdaudioC0D0: dig-out=0x1e/0x0 [ 141.586045] snd_hda_codec_realtek hdaudioC0D0: inputs: [ 141.586056] snd_hda_codec_realtek hdaudioC0D0: Mic=0x19 [ 141.719347] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input23 [ 141.722520] input: HDA Intel PCH Headphone Front as /devices/pci0000:00/0000:00:1b.0/sound/card0/input24 [ 141.728411] input: HDA Intel PCH Front Headphone Surround as /devices/pci0000:00/0000:00:1b.0/sound/card0/input25 [ 141.732862] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input26 [ 141.866989] [drm] Module unloaded [ 141.998082] Setting dangerous option enable_psr - tainting kernel [ 141.998104] Setting dangerous option inject_load_failure - tainting kernel [ 142.051188] [drm] Injecting failure at checkpoint 3 [i915_driver_init_hw:1178] [ 142.110115] snd_hda_intel 0000:00:1b.0: failed to add i915 component master (-19) [ 142.122395] snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC283: line_outs=2 (0x1b/0x21/0x0/0x0/0x0) type:hp [ 142.122420] snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 142.122436] snd_hda_codec_realtek hdaudioC0D0: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 142.122450] snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 [ 142.122461] snd_hda_codec_realtek hdaudioC0D0: dig-out=0x1e/0x0 [ 142.122471] snd_hda_codec_realtek hdaudioC0D0: inputs: [ 142.122482] snd_hda_codec_realtek hdaudioC0D0: Mic=0x19 [ 142.236065] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input27 [ 142.239370] input: HDA Intel PCH Headphone Front as /devices/pci0000:00/0000:00:1b.0/sound/card0/input28 [ 142.241975] input: HDA Intel PCH Front Headphone Surround as /devices/pci0000:00/0000:00:1b.0/sound/card0/input29 [ 142.244458] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input30 [ 142.374255] [drm] Module unloaded [ 142.493206] Setting dangerous option enable_psr - tainting kernel [ 142.493229] Setting dangerous option inject_load_failure - tainting kernel [ 142.545415] [drm] Memory usable by graphics device = 2048M [ 142.545468] [drm] Replacing VGA console driver [ 142.546094] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). [ 142.546106] [drm] Driver supports precise vblank timestamp query. [ 142.546117] [drm] Injecting failure at checkpoint 4 [i915_load_modeset_init:433] [ 142.607793] snd_hda_intel 0000:00:1b.0: failed to add i915 component master (-19) [ 142.620262] snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC283: line_outs=2 (0x1b/0x21/0x0/0x0/0x0) type:hp [ 142.620288] snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 142.620304] snd_hda_codec_realtek hdaudioC0D0: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 142.620702] snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 [ 142.620716] snd_hda_codec_realtek hdaudioC0D0: dig-out=0x1e/0x0 [ 142.620726] snd_hda_codec_realtek hdaudioC0D0: inputs: [ 142.620737] snd_hda_codec_realtek hdaudioC0D0: Mic=0x19 [ 142.719836] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input31 [ 142.724839] input: HDA Intel PCH Headphone Front as /devices/pci0000:00/0000:00:1b.0/sound/card0/input32 [ 142.731965] input: HDA Intel PCH Front Headphone Surround as /devices/pci0000:00/0000:00:1b.0/sound/card0/input33 [ 142.737669] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input34 [ 142.885595] [drm] Module unloaded [ 143.022203] Setting dangerous option enable_psr - tainting kernel [ 143.082722] [drm] Memory usable by graphics device = 2048M [ 143.082774] [drm] Replacing VGA console driver [ 143.083771] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). [ 143.083785] [drm] Driver supports precise vblank timestamp query. [ 143.400773] ACPI: Video Device [GFX0] (multi-head: yes rom: no post: no) [ 143.405352] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input35 [ 143.408959] [drm] Initialized i915 1.6.0 20160314 for 0000:00:02.0 on minor 0 [ 143.490015] fbcon: inteldrmfb (fb0) is primary device [ 143.917831] Console: switching to colour frame buffer device 240x67 [ 143.940979] i915 0000:00:02.0: fb0: inteldrmfb frame buffer device [ 143.970294] snd_hda_intel 0000:00:1b.0: bound 0000:00:02.0 (ops i915_audio_component_bind_ops [i915]) [ 143.995448] gem_exec_store: executing [ 144.008646] snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC283: line_outs=2 (0x1b/0x21/0x0/0x0/0x0) type:hp [ 144.008777] snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 144.008859] snd_hda_codec_realtek hdaudioC0D0: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) [ 144.008954] snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 [ 144.009020] snd_hda_codec_realtek hdaudioC0D0: dig-out=0x1e/0x0 [ 144.009082] snd_hda_codec_realtek hdaudioC0D0: inputs: [ 144.009138] snd_hda_codec_realtek hdaudioC0D0: Mic=0x19 [ 144.016268] gem_exec_store: starting subtest basic-default [ 144.018095] gem_exec_store: starting subtest basic-render [ 144.019936] gem_exec_store: starting subtest basic-bsd [ 144.021705] gem_exec_store: starting subtest basic-bsd1 [ 144.022249] gem_exec_store: starting subtest basic-bsd2 [ 144.023024] gem_exec_store: starting subtest basic-blt [ 144.024539] gem_exec_store: starting subtest basic-vebox [ 144.025667] gem_exec_store: exiting, ret=0 [ 144.141280] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input36 [ 144.144296] input: HDA Intel PCH Headphone Front as /devices/pci0000:00/0000:00:1b.0/sound/card0/input37 [ 144.147745] input: HDA Intel PCH Front Headphone Surround as /devices/pci0000:00/0000:00:1b.0/sound/card0/input38 [ 144.152204] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input39 [ 144.220721] gem_ctx_param_basic: executing [ 144.229727] gem_ctx_param_basic: starting subtest root-set-no-zeromap-disabled [ 144.230656] gem_ctx_param_basic: exiting, ret=0 [ 144.379265] gem_sync: executing [ 144.388873] gem_sync: starting subtest basic-vebox [ 155.285120] gem_sync: exiting, ret=0 [ 155.455556] drv_getparams_basic: executing [ 155.465726] drv_getparams_basic: starting subtest basic-subslice-total [ 155.466203] drv_getparams_basic: exiting, ret=0 [ 155.631892] kms_pipe_crc_basic: executing [ 155.651192] kms_pipe_crc_basic: starting subtest bad-source [ 155.652028] kms_pipe_crc_basic: exiting, ret=0 [ 155.823039] gem_ctx_param_basic: executing [ 155.833441] gem_ctx_param_basic: starting subtest root-set-no-zeromap-enabled [ 155.834091] gem_ctx_param_basic: exiting, ret=0 [ 155.997686] kms_pipe_crc_basic: executing [ 156.018587] kms_pipe_crc_basic: starting subtest read-crc-pipe-C-frame-sequence [ 156.760832] kms_pipe_crc_basic: exiting, ret=0 [ 156.984015] gem_exec_store: executing [ 156.994260] gem_exec_store: starting subtest basic-default [ 156.995863] gem_exec_store: exiting, ret=0 [ 157.152270] kms_pipe_crc_basic: executing [ 157.172770] kms_pipe_crc_basic: starting subtest bad-pipe [ 157.173329] kms_pipe_crc_basic: exiting, ret=0 [ 157.339163] gem_exec_store: executing [ 157.352296] gem_exec_store: starting subtest basic-blt [ 157.356522] gem_exec_store: exiting, ret=0 [ 157.517559] gem_mmap_gtt: executing [ 157.530769] gem_mmap_gtt: starting subtest basic-write-read [ 157.572280] gem_mmap_gtt: exiting, ret=0 [ 157.730585] gem_mmap_gtt: executing [ 157.743205] gem_mmap_gtt: starting subtest basic-write-cpu-read-gtt [ 157.746258] gem_mmap_gtt: exiting, ret=0 [ 157.899405] gem_mmap_gtt: executing [ 157.911049] gem_mmap_gtt: starting subtest basic-write-no-prefault [ 157.913788] Setting dangerous option prefault_disable - tainting kernel [ 158.470532] Setting dangerous option prefault_disable - tainting kernel [ 158.474075] gem_mmap_gtt: exiting, ret=0 [ 158.476919] Setting dangerous option prefault_disable - tainting kernel [ 158.646018] gem_exec_store: executing [ 158.657896] gem_exec_store: starting subtest basic-render [ 158.661865] gem_exec_store: exiting, ret=0 [ 158.815458] gem_cs_prefetch: executing [ 158.818209] gem_cs_prefetch: starting subtest basic-default [ 158.830885] gem_cs_prefetch (6180): drop_caches: 4 [ 158.834187] gem_cs_prefetch: exiting, ret=0 [ 158.987199] gem_storedw_loop: executing [ 158.998477] gem_storedw_loop: starting subtest basic-blt [ 164.989525] gem_storedw_loop: exiting, ret=0 [ 165.765541] gem_ctx_param_basic: executing [ 165.777951] gem_ctx_param_basic: starting subtest invalid-param-set [ 165.781218] gem_ctx_param_basic: exiting, ret=0 [ 165.943440] gem_sync: executing [ 165.956558] gem_sync: starting subtest basic-render [ 176.105896] gem_sync: exiting, ret=0 [ 176.267471] kms_addfb_basic: executing [ 176.279808] kms_addfb_basic: starting subtest too-wide [ 176.283296] kms_addfb_basic: exiting, ret=0 [ 176.449996] kms_addfb_basic: executing [ 176.462744] kms_addfb_basic: starting subtest unused-offsets [ 176.466300] kms_addfb_basic: exiting, ret=0 [ 176.634435] kms_pipe_crc_basic: executing [ 176.656440] kms_pipe_crc_basic: starting subtest nonblocking-crc-pipe-B [ 176.656945] kms_pipe_crc_basic: exiting, ret=0 [ 176.822482] kms_addfb_basic: executing [ 176.834235] kms_addfb_basic: starting subtest addfb25-framebuffer-vs-set-tiling [ 176.837313] kms_addfb_basic: exiting, ret=0 [ 176.989507] gem_exec_basic: executing [ 177.000532] gem_exec_basic: starting subtest gtt-blt [ 177.004281] gem_exec_basic: exiting, ret=0 [ 177.174812] pm_backlight: executing [ 177.177921] pm_backlight: exiting, ret=0 [ 177.336904] kms_flip: executing [ 177.349834] kms_flip: starting subtest basic-flip-vs-dpms [ 238.078998] kms_flip: exiting, ret=0 [ 238.555011] gem_pread: executing [ 238.567333] gem_pread: starting subtest basic [ 239.402766] gem_pread: exiting, ret=0 [ 239.570403] gem_mmap_gtt: executing [ 239.583265] gem_mmap_gtt: starting subtest basic-short [ 239.703499] gem_mmap_gtt: exiting, ret=0 [ 239.884489] gem_ctx_param_basic: executing [ 239.896536] gem_ctx_param_basic: starting subtest basic-default [ 239.899439] gem_ctx_param_basic: exiting, ret=0 [ 240.084448] pm_rpm: executing [ 241.178425] pm_rpm: starting subtest basic-rte [ 241.689751] pm_rpm: exiting, ret=0 [ 241.924254] gem_ctx_param_basic: executing [ 241.937634] gem_ctx_param_basic: starting subtest invalid-ctx-set [ 241.940133] gem_ctx_param_basic: exiting, ret=0 [ 242.117316] kms_addfb_basic: executing [ 242.138852] kms_addfb_basic: starting subtest too-high [ 242.144030] kms_addfb_basic: exiting, ret=0 [ 242.313076] gem_mmap_gtt: executing [ 242.325712] gem_mmap_gtt: starting subtest basic-read-write-distinct [ 242.366527] gem_mmap_gtt: exiting, ret=0 [ 242.554665] kms_pipe_crc_basic: executing [ 242.577045] kms_pipe_crc_basic: starting subtest bad-nb-words-3 [ 242.577410] kms_pipe_crc_basic: exiting, ret=0 [ 242.770628] kms_pipe_crc_basic: executing [ 242.790986] kms_pipe_crc_basic: starting subtest read-crc-pipe-A [ 242.791514] kms_pipe_crc_basic: exiting, ret=0 [ 242.957681] gem_mmap_gtt: executing [ 242.968256] gem_mmap_gtt: starting subtest basic-read-no-prefault [ 242.970417] Setting dangerous option prefault_disable - tainting kernel [ 243.045075] Setting dangerous option prefault_disable - tainting kernel [ 243.047498] gem_mmap_gtt: exiting, ret=0 [ 243.050236] Setting dangerous option prefault_disable - tainting kernel [ 243.204999] gem_flink_basic: executing [ 243.215747] gem_flink_basic: starting subtest basic [ 243.218264] gem_flink_basic: exiting, ret=0 [ 243.373616] gem_mmap_gtt: executing [ 243.384473] gem_mmap_gtt: starting subtest basic-write-gtt [ 244.443385] gem_mmap_gtt: exiting, ret=0 [ 244.601260] gem_tiled_blits: executing [ 244.612342] gem_tiled_blits: starting subtest basic [ 244.647771] gem_tiled_blits: exiting, ret=0 [ 244.803878] gem_exec_basic: executing [ 244.816008] gem_exec_basic: starting subtest readonly-render [ 244.819536] gem_exec_basic: exiting, ret=0 [ 244.973499] gem_flink_basic: executing [ 244.984557] gem_flink_basic: starting subtest bad-flink [ 244.987389] gem_flink_basic: exiting, ret=0 [ 245.139981] gem_storedw_loop: executing [ 245.151199] gem_storedw_loop: starting subtest basic-bsd1 [ 245.154186] gem_storedw_loop: exiting, ret=0 [ 245.323368] gem_storedw_loop: executing [ 245.336480] gem_storedw_loop: starting subtest basic-bsd2 [ 245.339133] gem_storedw_loop: exiting, ret=0 [ 245.509330] kms_pipe_crc_basic: executing [ 245.530939] kms_pipe_crc_basic: starting subtest read-crc-pipe-B [ 245.531443] kms_pipe_crc_basic: exiting, ret=0 [ 245.704619] gem_basic: executing [ 245.717287] gem_basic: starting subtest create-fd-close [ 245.720756] gem_basic: exiting, ret=0 [ 245.912728] gem_ctx_param_basic: executing [ 245.923654] gem_ctx_param_basic: starting subtest invalid-size-set [ 245.926151] gem_ctx_param_basic: exiting, ret=0 [ 246.082194] gem_exec_basic: executing [ 246.093403] gem_exec_basic: starting subtest gtt-default [ 246.097165] gem_exec_basic: exiting, ret=0 [ 246.263388] core_prop_blob: executing [ 246.266293] core_prop_blob: starting subtest basic [ 246.269164] core_prop_blob: exiting, ret=0 [ 246.415933] kms_addfb_basic: executing [ 246.427091] kms_addfb_basic: starting subtest basic-X-tiled [ 246.430466] kms_addfb_basic: exiting, ret=0 [ 246.607884] gem_mmap_gtt: executing [ 246.618533] gem_mmap_gtt: starting subtest basic-small-bo-tiledY [ 246.797844] gem_mmap_gtt: exiting, ret=0 [ 246.977903] gem_exec_basic: executing [ 246.989544] gem_exec_basic: starting subtest readonly-blt [ 246.992638] gem_exec_basic: exiting, ret=0 [ 247.157689] gem_mmap_gtt: executing [ 247.168886] gem_mmap_gtt: starting subtest basic-small-bo-tiledX [ 247.349267] gem_mmap_gtt: exiting, ret=0 [ 247.508934] gem_render_linear_blits: executing [ 247.521271] gem_render_linear_blits: starting subtest basic [ 247.554827] gem_render_linear_blits: exiting, ret=0 [ 247.724935] kms_force_connector_basic: executing [ 247.737114] kms_force_connector_basic: exiting, ret=0 [ 247.899993] gem_exec_basic: executing [ 247.911864] gem_exec_basic: starting subtest readonly-bsd [ 247.915114] gem_exec_basic: exiting, ret=0 [ 248.067972] kms_addfb_basic: executing [ 248.080958] kms_addfb_basic: starting subtest addfb25-modifier-no-flag [ 248.084039] kms_addfb_basic: exiting, ret=0 [ 248.237971] kms_addfb_basic: executing [ 248.250326] kms_addfb_basic: starting subtest bad-pitch-1024 [ 248.253788] kms_addfb_basic: exiting, ret=0 [ 248.417780] gem_ctx_exec: executing [ 248.430801] gem_ctx_exec: starting subtest basic [ 248.436253] gem_ctx_exec: exiting, ret=0 [ 248.589448] gem_ringfill: executing [ 248.600220] gem_ringfill: starting subtest basic-default-interruptible [ 251.526566] gem_ringfill: exiting, ret=0 [ 251.715071] kms_addfb_basic: executing [ 251.726378] kms_addfb_basic: starting subtest bad-pitch-32 [ 251.729709] kms_addfb_basic: exiting, ret=0 [ 251.904658] gem_exec_basic: executing [ 251.917839] gem_exec_basic: starting subtest basic-bsd2 [ 251.920171] gem_exec_basic: exiting, ret=0 [ 252.079485] kms_addfb_basic: executing [ 252.090789] kms_addfb_basic: starting subtest basic-Y-tiled [ 252.093508] kms_addfb_basic: exiting, ret=0 [ 252.268416] gem_exec_basic: executing [ 252.280011] gem_exec_basic: starting subtest gtt-render [ 252.283613] gem_exec_basic: exiting, ret=0 [ 252.451366] kms_pipe_crc_basic: executing [ 252.473037] kms_pipe_crc_basic: starting subtest hang-read-crc-pipe-B [ 259.797932] [drm] stuck on render ring [ 259.807068] [drm] GPU HANG: ecode 8:0:0xfffffffe, in kms_pipe_crc_ba [6326], reason: Engine(s) hung, action: reset [ 259.807074] [drm] GPU hangs can indicate a bug anywhere in the entire gfx stack, including userspace. [ 259.807077] [drm] Please file a _new_ bug report on bugs.freedesktop.org against DRI -> DRM/Intel [ 259.807080] [drm] drm/i915 developers can then reassign to the right component if it's not a kernel issue. [ 259.807082] [drm] The gpu crash dump is required to analyze gpu hangs, so please always attach it. [ 259.807085] [drm] GPU crash dump saved to /sys/class/drm/card0/error [ 259.814000] [drm] Simulated gpu hang, resetting stop_rings [ 259.814010] drm/i915: Resetting chip after gpu hang [ 259.815847] kms_pipe_crc_basic: exiting, ret=0 [ 260.013523] kms_pipe_crc_basic: executing [ 260.035062] kms_pipe_crc_basic: starting subtest read-crc-pipe-A-frame-sequence [ 260.035368] kms_pipe_crc_basic: exiting, ret=0 [ 260.235083] prime_self_import: executing [ 260.237364] prime_self_import: starting subtest basic-llseek-bad [ 260.249517] prime_self_import: exiting, ret=0 [ 260.422271] gem_exec_basic: executing [ 260.433528] gem_exec_basic: starting subtest basic-bsd [ 260.437009] gem_exec_basic: exiting, ret=0 [ 260.596570] gem_mmap_gtt: executing [ 260.607629] gem_mmap_gtt: starting subtest basic [ 260.610695] gem_mmap_gtt: exiting, ret=0 [ 260.768074] kms_pipe_crc_basic: executing [ 260.788729] kms_pipe_crc_basic: starting subtest read-crc-pipe-C [ 261.515780] kms_pipe_crc_basic: exiting, ret=0 [ 261.727852] gem_tiled_pread_basic: executing [ 282.317113] gem_tiled_pread_basic: exiting, ret=0 [ 282.486563] gem_mmap_gtt: executing [ 282.498852] gem_mmap_gtt: starting subtest basic-small-copy [ 285.887438] gem_mmap_gtt: exiting, ret=0 [ 286.094812] gem_mmap_gtt: executing [ 286.107188] gem_mmap_gtt: starting subtest basic-write-gtt-no-prefault [ 286.109302] Setting dangerous option prefault_disable - tainting kernel [ 286.688658] Setting dangerous option prefault_disable - tainting kernel [ 286.691412] gem_mmap_gtt: exiting, ret=0 [ 286.693559] Setting dangerous option prefault_disable - tainting kernel [ 286.887064] gem_exec_basic: executing [ 286.899113] gem_exec_basic: starting subtest gtt-bsd [ 286.902870] gem_exec_basic: exiting, ret=0 [ 287.056321] gem_cpu_reloc: executing [ 287.067549] gem_cpu_reloc: starting subtest basic [ 287.086222] gem_cpu_reloc: exiting, ret=0 [ 287.241241] pm_rps: executing [ 287.254865] pm_rps: starting subtest basic-api [ 287.268933] pm_rps: exiting, ret=0 [ 287.429175] gem_pwrite: executing [ 287.440116] gem_pwrite: starting subtest basic [ 288.369308] gem_pwrite: exiting, ret=0 [ 288.553286] gem_sync: executing [ 288.564267] gem_sync: starting subtest basic-bsd1 [ 288.566440] gem_sync: exiting, ret=0 [ 288.745171] gem_ctx_create: executing [ 288.757003] gem_ctx_create: starting subtest basic [ 288.759612] gem_ctx_create: exiting, ret=0 [ 288.941110] gem_flink_basic: executing [ 288.951776] gem_flink_basic: starting subtest bad-open [ 288.953970] gem_flink_basic: exiting, ret=0 [ 289.160948] gem_mmap_gtt: executing [ 289.171644] gem_mmap_gtt: starting subtest basic-write [ 289.731171] gem_mmap_gtt: exiting, ret=0 [ 289.914440] gem_basic: executing [ 289.926330] gem_basic: starting subtest bad-close [ 289.928910] gem_basic: exiting, ret=0 [ 290.093052] kms_addfb_basic: executing [ 290.105521] kms_addfb_basic: starting subtest addfb25-X-tiled [ 290.108255] kms_addfb_basic: exiting, ret=0 [ 290.270616] gem_storedw_loop: executing [ 290.282055] gem_storedw_loop: starting subtest basic-default [ 296.757818] gem_storedw_loop: exiting, ret=0 [ 297.206644] kms_pipe_crc_basic: executing [ 297.228162] kms_pipe_crc_basic: starting subtest nonblocking-crc-pipe-C-frame-sequence [ 297.960673] kms_pipe_crc_basic: exiting, ret=0 [ 298.194853] gem_exec_basic: executing [ 298.206853] gem_exec_basic: starting subtest readonly-bsd2 [ 298.209188] gem_exec_basic: exiting, ret=0 [ 298.369136] prime_self_import: executing [ 298.371376] prime_self_import: starting subtest basic-with_one_bo [ 298.463319] prime_self_import: exiting, ret=0 [ 298.617994] kms_force_connector_basic: executing [ 298.628840] kms_force_connector_basic: exiting, ret=0 [ 298.787439] kms_addfb_basic: executing [ 298.798545] kms_addfb_basic: starting subtest clobberred-modifier [ 298.801738] kms_addfb_basic: exiting, ret=0 [ 298.966035] kms_addfb_basic: executing [ 298.976879] kms_addfb_basic: starting subtest no-handle [ 298.979963] kms_addfb_basic: exiting, ret=0 [ 299.132580] gem_render_tiled_blits: executing [ 299.143160] gem_render_tiled_blits: starting subtest basic [ 299.174625] gem_render_tiled_blits: exiting, ret=0 [ 299.329648] kms_force_connector_basic: executing [ 299.340158] kms_force_connector_basic: exiting, ret=0 [ 299.492411] kms_addfb_basic: executing [ 299.503240] kms_addfb_basic: starting subtest bad-pitch-63 [ 299.506226] kms_addfb_basic: exiting, ret=0 [ 299.658993] gem_ctx_param_basic: executing [ 299.669472] gem_ctx_param_basic: starting subtest invalid-param-get [ 299.672238] gem_ctx_param_basic: exiting, ret=0 [ 299.830847] gem_exec_basic: executing [ 299.841347] gem_exec_basic: starting subtest basic-blt [ 299.844267] gem_exec_basic: exiting, ret=0 [ 300.006341] gem_exec_basic: executing [ 300.016769] gem_exec_basic: starting subtest basic-default [ 300.019774] gem_exec_basic: exiting, ret=0 [ 300.173105] gem_exec_basic: executing [ 300.183975] gem_exec_basic: starting subtest basic-render [ 300.187014] gem_exec_basic: exiting, ret=0 [ 300.340011] gem_ctx_param_basic: executing [ 300.350979] gem_ctx_param_basic: starting subtest non-root-set-no-zeromap [ 300.367048] gem_ctx_param_basic: exiting, ret=0 [ 300.533643] gem_flink_basic: executing [ 300.544390] gem_flink_basic: starting subtest double-flink [ 300.546703] gem_flink_basic: exiting, ret=0 [ 300.699850] kms_addfb_basic: executing [ 300.711035] kms_addfb_basic: starting subtest bo-too-small-due-to-tiling [ 300.714236] kms_addfb_basic: exiting, ret=0 [ 300.869457] gem_sync: executing [ 300.880579] gem_sync: starting subtest basic-blt [ 311.988623] gem_sync: exiting, ret=0 [ 312.149314] kms_frontbuffer_tracking: executing [ 312.164503] kms_frontbuffer_tracking: starting subtest basic [ 316.147436] kms_frontbuffer_tracking: exiting, ret=0 [ 316.360037] drv_getparams_basic: executing [ 316.371599] drv_getparams_basic: starting subtest basic-eu-total [ 316.374203] drv_getparams_basic: exiting, ret=0 [ 316.527591] gem_ctx_param_basic: executing [ 316.538534] gem_ctx_param_basic: starting subtest basic [ 316.541447] gem_ctx_param_basic: exiting, ret=0 [ 316.694500] gem_flink_basic: executing [ 316.705341] gem_flink_basic: starting subtest flink-lifetime [ 316.709054] gem_flink_basic: exiting, ret=0 [ 316.869032] gem_ctx_param_basic: executing [ 316.879736] gem_ctx_param_basic: starting subtest invalid-ctx-get [ 316.882533] gem_ctx_param_basic: exiting, ret=0 [ 317.049233] kms_pipe_crc_basic: executing [ 317.069854] kms_pipe_crc_basic: starting subtest nonblocking-crc-pipe-B-frame-sequence [ 317.070354] kms_pipe_crc_basic: exiting, ret=0 [ 317.241072] kms_flip: executing [ 317.254001] kms_flip: starting subtest basic-flip-vs-wf_vblank [ 348.836348] kms_flip: exiting, ret=0 [ 349.072925] gem_exec_basic: executing [ 349.084886] gem_exec_basic: starting subtest basic-vebox [ 349.088390] gem_exec_basic: exiting, ret=0 [ 349.255356] gem_mmap: executing [ 349.267257] gem_mmap: starting subtest basic [ 349.270373] gem_mmap: exiting, ret=0 [ 349.436779] kms_addfb_basic: executing [ 349.448399] kms_addfb_basic: starting subtest addfb25-bad-modifier [ 349.451382] kms_addfb_basic: exiting, ret=0 [ 349.617332] pm_rpm: executing [ 350.699452] pm_rpm: starting subtest basic-pci-d3-state [ 351.196955] pm_rpm: exiting, ret=0 [ 351.393319] gem_basic: executing [ 351.405634] gem_basic: starting subtest create-close [ 351.408386] gem_basic: exiting, ret=0 [ 351.571284] gem_sync: executing [ 351.583449] gem_sync: starting subtest basic-bsd [ 362.155826] gem_sync: exiting, ret=0 [ 362.328108] kms_flip: executing [ 362.340835] kms_flip: starting subtest basic-flip-vs-modeset [ 423.231432] kms_flip: exiting, ret=0 [ 423.725516] gem_exec_parse: executing [ 423.737112] gem_exec_parse: exiting, ret=0 [ 423.892089] gem_exec_store: executing [ 423.904200] gem_exec_store: starting subtest basic-bsd2 [ 423.906721] gem_exec_store: exiting, ret=0 [ 424.062589] gem_exec_basic: executing [ 424.075699] gem_exec_basic: starting subtest readonly-vebox [ 424.079301] gem_exec_basic: exiting, ret=0 [ 424.246582] gem_linear_blits: executing [ 424.257459] gem_linear_blits: starting subtest basic [ 424.289283] gem_linear_blits: exiting, ret=0 [ 424.484849] kms_pipe_crc_basic: executing [ 424.505474] kms_pipe_crc_basic: starting subtest nonblocking-crc-pipe-A-frame-sequence [ 424.505775] kms_pipe_crc_basic: exiting, ret=0 [ 424.693058] prime_self_import: executing [ 424.695578] prime_self_import: starting subtest basic-with_two_bos [ 424.740540] prime_self_import: exiting, ret=0 [ 424.896469] gem_ctx_param_basic: executing [ 424.907563] gem_ctx_param_basic: starting subtest invalid-size-get [ 424.910642] gem_ctx_param_basic: exiting, ret=0 [ 425.093428] kms_force_connector_basic: executing [ 425.104213] kms_force_connector_basic: exiting, ret=0 [ 425.291208] kms_pipe_crc_basic: executing [ 425.311833] kms_pipe_crc_basic: starting subtest bad-nb-words-1 [ 425.312669] kms_pipe_crc_basic: exiting, ret=0 [ 425.482735] kms_setmode: executing [ 425.495124] kms_setmode: starting subtest basic-clone-single-crtc [ 425.563411] kms_setmode: exiting, ret=0 [ 425.737137] gem_exec_suspend: executing [ 425.749436] gem_exec_suspend: starting subtest basic-S3 [ 427.867361] PM: Syncing filesystems ... done. [ 427.878733] Freezing user space processes ... (elapsed 0.001 seconds) done. [ 427.882532] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [ 427.885835] Suspending console(s) (use no_console_suspend to debug) [ 427.889755] sd 0:0:0:0: [sda] Synchronizing SCSI cache [ 427.889932] sd 0:0:0:0: [sda] Stopping disk [ 428.014119] PM: suspend of devices complete after 125.493 msecs [ 428.047466] PM: late suspend of devices complete after 33.319 msecs [ 428.053248] r8169 0000:03:00.0: System wakeup enabled by ACPI [ 428.060252] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI [ 428.070280] PM: noirq suspend of devices complete after 22.804 msecs [ 428.070341] ACPI: Preparing to enter system sleep state S3 [ 428.084863] PM: Saving platform NVS memory [ 428.084987] Disabling non-boot CPUs ... [ 428.093509] Broke affinity for irq 115 [ 428.093522] Broke affinity for irq 116 [ 428.094752] smpboot: CPU 1 is now offline [ 428.098047] ACPI: Low-level resume complete [ 428.098285] PM: Restoring platform NVS memory [ 428.099000] Enabling non-boot CPUs ... [ 428.099429] x86: Booting SMP configuration: [ 428.099434] smpboot: Booting Node 0 Processor 1 APIC 0x4 [ 428.104519] cache: parent cpu1 should not be sleeping [ 428.112892] CPU1 is up [ 428.113873] ACPI: Waking up from system sleep state S3 [ 428.160710] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI [ 428.168850] PM: noirq resume of devices complete after 15.334 msecs [ 429.227565] PM: early resume of devices complete after 1058.648 msecs [ 429.233060] r8169 0000:03:00.0: System wakeup disabled by ACPI [ 429.237852] sd 0:0:0:0: [sda] Starting disk [ 429.245942] r8169 0000:03:00.0 eth0: link down [ 429.540034] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) [ 429.541515] ata2: SATA link down (SStatus 4 SControl 300) [ 429.558452] ata1.00: configured for UDMA/133 [ 429.722111] PM: resume of devices complete after 494.526 msecs [ 429.819228] Restarting tasks ... done. [ 431.492319] gem_exec_suspend: exiting, ret=0 [ 431.679185] kms_psr_sink_crc: executing [ 431.690540] Setting dangerous option enable_psr - tainting kernel [ 431.691497] kms_psr_sink_crc: exiting, ret=0 [ 431.692050] Setting dangerous option enable_psr - tainting kernel [ 431.891153] kms_pipe_crc_basic: executing [ 431.911942] kms_pipe_crc_basic: starting subtest suspend-read-crc-pipe-C [ 432.041336] PM: Syncing filesystems ... done. [ 432.052111] Freezing user space processes ... (elapsed 0.001 seconds) done. [ 432.053908] Freezing remaining freezable tasks ... (elapsed 0.000 seconds) done. [ 432.054953] Suspending console(s) (use no_console_suspend to debug) [ 432.057089] sd 0:0:0:0: [sda] Synchronizing SCSI cache [ 432.057272] sd 0:0:0:0: [sda] Stopping disk [ 432.167514] PM: suspend of devices complete after 111.635 msecs [ 432.194133] PM: late suspend of devices complete after 26.597 msecs [ 432.198286] r8169 0000:03:00.0: System wakeup enabled by ACPI [ 432.206124] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI [ 432.212824] PM: noirq suspend of devices complete after 18.683 msecs [ 432.212873] ACPI: Preparing to enter system sleep state S3 [ 432.224864] PM: Saving platform NVS memory [ 432.224985] Disabling non-boot CPUs ... [ 432.233190] Broke affinity for irq 115 [ 432.233203] Broke affinity for irq 116 [ 432.234432] smpboot: CPU 1 is now offline [ 432.237763] ACPI: Low-level resume complete [ 432.238003] PM: Restoring platform NVS memory [ 432.238725] Enabling non-boot CPUs ... [ 432.239163] x86: Booting SMP configuration: [ 432.239165] smpboot: Booting Node 0 Processor 1 APIC 0x4 [ 432.243924] cache: parent cpu1 should not be sleeping [ 432.252398] CPU1 is up [ 432.253185] ACPI: Waking up from system sleep state S3 [ 432.298637] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI [ 432.307477] PM: noirq resume of devices complete after 15.326 msecs [ 433.366188] PM: early resume of devices complete after 1058.641 msecs [ 433.369017] r8169 0000:03:00.0: System wakeup disabled by ACPI [ 433.377159] sd 0:0:0:0: [sda] Starting disk [ 433.383198] r8169 0000:03:00.0 eth0: link down [ 433.674782] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) [ 433.677035] ata2: SATA link down (SStatus 4 SControl 300) [ 433.693167] ata1.00: configured for UDMA/133 [ 433.816610] PM: resume of devices complete after 450.412 msecs [ 433.817631] Restarting tasks ... done. [ 434.549205] kms_pipe_crc_basic: exiting, ret=0 [ 434.794701] gem_exec_basic: executing [ 434.805748] gem_exec_basic: starting subtest gtt-bsd2 [ 434.808820] gem_exec_basic: exiting, ret=0 [ 434.975901] kms_pipe_crc_basic: executing [ 434.996676] kms_pipe_crc_basic: starting subtest read-crc-pipe-B-frame-sequence [ 434.997185] kms_pipe_crc_basic: exiting, ret=0 [ 435.171671] kms_addfb_basic: executing [ 435.182878] kms_addfb_basic: starting subtest tile-pitch-mismatch [ 435.186666] kms_addfb_basic: exiting, ret=0 [ 435.349218] kms_addfb_basic: executing [ 435.360884] kms_addfb_basic: starting subtest addfb25-Y-tiled-small [ 435.364091] kms_addfb_basic: exiting, ret=0 [ 435.527368] gem_ringfill: executing [ 435.538161] gem_ringfill: starting subtest basic-default-hang [ 436.682142] r8169 0000:03:00.0 eth0: link up [ 447.804780] [drm] stuck on render ring [ 447.824732] [drm] GPU HANG: ecode 8:0:0xe757fffe, in gem_ringfill [6553], reason: Engine(s) hung, action: reset [ 447.835931] drm/i915: Resetting chip after gpu hang [ 448.241308] gem_ringfill: exiting, ret=0 [ 448.436153] gem_storedw_loop: executing [ 448.450560] gem_storedw_loop: starting subtest basic-render [ 454.152060] gem_storedw_loop: exiting, ret=0 [ 454.934837] kms_addfb_basic: executing [ 454.946051] kms_addfb_basic: starting subtest unused-modifier [ 454.949963] kms_addfb_basic: exiting, ret=0 [ 455.119058] gem_exec_suspend: executing [ 455.130852] gem_exec_suspend: starting subtest basic-S4 [ 457.259059] gem_exec_suspend: exiting, ret=0 [ 457.457765] kms_addfb_basic: executing [ 457.469172] kms_addfb_basic: starting subtest bad-pitch-65536 [ 457.472723] kms_addfb_basic: exiting, ret=0 [ 457.654574] prime_self_import: executing [ 457.657208] prime_self_import: starting subtest basic-with_one_bo_two_files [ 457.669353] prime_self_import: exiting, ret=0 [ 457.865207] kms_addfb_basic: executing [ 457.877709] kms_addfb_basic: starting subtest bad-pitch-999 [ 457.881105] kms_addfb_basic: exiting, ret=0 [ 458.086041] gem_exec_basic: executing [ 458.099228] gem_exec_basic: starting subtest gtt-bsd1 [ 458.101712] gem_exec_basic: exiting, ret=0 [ 458.294941] gem_tiled_fence_blits: executing [ 458.305223] gem_tiled_fence_blits: starting subtest basic [ 458.325854] gem_tiled_fence_blits: exiting, ret=0 [ 458.490080] kms_flip: executing [ 458.501649] kms_flip: starting subtest basic-plain-flip [ 489.085551] kms_flip: exiting, ret=0 [ 489.317865] kms_addfb_basic: executing [ 489.328686] kms_addfb_basic: starting subtest framebuffer-vs-set-tiling [ 489.332160] kms_addfb_basic: exiting, ret=0 [ 489.525148] gem_sync: executing [ 489.538988] gem_sync: starting subtest basic-default [ 500.562166] gem_sync: exiting, ret=0 [ 500.739366] kms_pipe_crc_basic: executing [ 500.762857] kms_pipe_crc_basic: starting subtest nonblocking-crc-pipe-A [ 500.763394] kms_pipe_crc_basic: exiting, ret=0 [ 500.943054] kms_addfb_basic: executing [ 500.957111] kms_addfb_basic: starting subtest bad-pitch-0 [ 500.960913] kms_addfb_basic: exiting, ret=0 [ 501.129849] kms_addfb_basic: executing [ 501.143798] kms_addfb_basic: starting subtest unused-pitches [ 501.147679] kms_addfb_basic: exiting, ret=0 [ 501.321339] kms_addfb_basic: executing [ 501.334734] kms_addfb_basic: starting subtest unused-handle [ 501.338587] kms_addfb_basic: exiting, ret=0 [ 501.510708] kms_pipe_crc_basic: executing [ 501.534884] kms_pipe_crc_basic: starting subtest hang-read-crc-pipe-A [ 508.801698] [drm] stuck on render ring [ 508.813030] [drm] GPU HANG: ecode 8:0:0xfffffffe, in kms_pipe_crc_ba [6615], reason: Engine(s) hung, action: reset [ 508.816867] [drm] Simulated gpu hang, resetting stop_rings [ 508.816883] drm/i915: Resetting chip after gpu hang [ 508.820328] kms_pipe_crc_basic: exiting, ret=0 [ 509.017775] gem_mmap_gtt: executing [ 509.028110] gem_mmap_gtt: starting subtest basic-small-copy-XY [ 512.419836] gem_mmap_gtt: exiting, ret=0 [ 512.630856] kms_pipe_crc_basic: executing [ 512.652412] kms_pipe_crc_basic: starting subtest suspend-read-crc-pipe-B [ 512.754078] PM: Syncing filesystems ... done. [ 512.763297] Freezing user space processes ... (elapsed 0.001 seconds) done. [ 512.765163] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [ 512.766688] Suspending console(s) (use no_console_suspend to debug) [ 512.769524] sd 0:0:0:0: [sda] Synchronizing SCSI cache [ 512.770688] sd 0:0:0:0: [sda] Stopping disk [ 512.879793] PM: suspend of devices complete after 111.913 msecs [ 512.904945] PM: late suspend of devices complete after 25.140 msecs [ 512.909042] r8169 0000:03:00.0: System wakeup enabled by ACPI [ 512.913098] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI [ 512.922519] PM: noirq suspend of devices complete after 17.567 msecs [ 512.922567] ACPI: Preparing to enter system sleep state S3 [ 512.935999] PM: Saving platform NVS memory [ 512.936120] Disabling non-boot CPUs ... [ 512.951116] Broke affinity for irq 116 [ 512.952435] smpboot: CPU 1 is now offline [ 512.962986] ACPI: Low-level resume complete [ 512.963225] PM: Restoring platform NVS memory [ 512.963947] Enabling non-boot CPUs ... [ 512.964417] x86: Booting SMP configuration: [ 512.964420] smpboot: Booting Node 0 Processor 1 APIC 0x4 [ 512.969257] cache: parent cpu1 should not be sleeping [ 512.977605] CPU1 is up [ 512.978651] ACPI: Waking up from system sleep state S3 [ 513.020823] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI [ 513.034259] PM: noirq resume of devices complete after 15.568 msecs [ 514.092949] PM: early resume of devices complete after 1058.624 msecs [ 514.099407] r8169 0000:03:00.0: System wakeup disabled by ACPI [ 514.103455] sd 0:0:0:0: [sda] Starting disk [ 514.113181] r8169 0000:03:00.0 eth0: link down [ 514.403663] ata2: SATA link down (SStatus 4 SControl 300) [ 514.405501] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) [ 514.423251] ata1.00: configured for UDMA/133 [ 514.567081] PM: resume of devices complete after 474.121 msecs [ 514.568080] Restarting tasks ... done. [ 514.577014] kms_pipe_crc_basic: exiting, ret=0 [ 514.809396] gem_mmap_gtt: executing [ 514.819156] gem_mmap_gtt: starting subtest basic-read-write [ 514.875343] gem_mmap_gtt: exiting, ret=0 [ 515.082252] kms_sink_crc_basic: executing [ 515.104550] kms_sink_crc_basic: exiting, ret=77 [ 515.308424] kms_addfb_basic: executing [ 515.322030] kms_addfb_basic: starting subtest addfb25-X-tiled-mismatch [ 515.324998] kms_addfb_basic: exiting, ret=0 [ 515.494032] kms_pipe_crc_basic: executing [ 515.515619] kms_pipe_crc_basic: starting subtest hang-read-crc-pipe-C [ 517.421119] r8169 0000:03:00.0 eth0: link up [ 521.802861] [drm] stuck on render ring [ 521.814252] [drm] GPU HANG: ecode 8:0:0xfffffffe, in kms_pipe_crc_ba [6640], reason: Engine(s) hung, action: reset [ 521.820651] [drm] Simulated gpu hang, resetting stop_rings [ 521.820668] drm/i915: Resetting chip after gpu hang [ 522.530165] kms_pipe_crc_basic: exiting, ret=0 [ 522.768386] gem_sync: executing [ 522.782013] gem_sync: starting subtest basic-bsd2 [ 522.784534] gem_sync: exiting, ret=0 [ 522.971690] gem_mmap_gtt: executing [ 522.982435] gem_mmap_gtt: starting subtest basic-write-read-distinct [ 523.023948] gem_mmap_gtt: exiting, ret=0 [ 523.216410] gem_exec_store: executing [ 523.226806] gem_exec_store: starting subtest basic-vebox [ 523.230349] gem_exec_store: exiting, ret=0 [ 523.412999] gem_exec_nop: executing [ 523.427016] gem_exec_nop: starting subtest basic [ 533.543361] gem_exec_nop: exiting, ret=0 [ 534.844738] gem_mmap: executing [ 534.855323] gem_mmap: starting subtest basic-small-bo [ 535.039733] gem_mmap: exiting, ret=0 [ 535.212247] kms_addfb_basic: executing [ 535.226318] kms_addfb_basic: starting subtest bad-pitch-256 [ 535.229851] kms_addfb_basic: exiting, ret=0 [ 535.430573] gem_mmap_gtt: executing [ 535.440670] gem_mmap_gtt: starting subtest basic-small-bo [ 535.597634] gem_mmap_gtt: exiting, ret=0 [ 535.789229] gem_ringfill: executing [ 535.800531] gem_ringfill: starting subtest basic-default-forked [ 536.648230] gem_ringfill: exiting, ret=0 [ 536.839595] gem_exec_basic: executing [ 536.850843] gem_exec_basic: starting subtest basic-bsd1 [ 536.853077] gem_exec_basic: exiting, ret=0 [ 537.045765] gem_ctx_basic: executing [ 551.305282] gem_ctx_basic: exiting, ret=0 [ 551.514301] kms_addfb_basic: executing [ 551.526168] kms_addfb_basic: starting subtest basic [ 551.529080] kms_addfb_basic: exiting, ret=0 [ 551.720380] kms_addfb_basic: executing [ 551.732490] kms_addfb_basic: starting subtest addfb25-Yf-tiled [ 551.735103] kms_addfb_basic: exiting, ret=0 [ 551.902813] gem_exec_basic: executing [ 551.915865] gem_exec_basic: starting subtest readonly-default [ 551.919237] gem_exec_basic: exiting, ret=0 [ 552.099587] gem_mmap_gtt: executing [ 552.113415] gem_mmap_gtt: starting subtest basic-read [ 552.189080] gem_mmap_gtt: exiting, ret=0 [ 552.364698] gem_exec_store: executing [ 552.378520] gem_exec_store: starting subtest basic-bsd1 [ 552.380833] gem_exec_store: exiting, ret=0 [ 552.549177] gem_ctx_param_basic: executing [ 552.563085] gem_ctx_param_basic: starting subtest root-set [ 552.565971] gem_ctx_param_basic: exiting, ret=0 [ 552.746019] gem_exec_whisper: executing [ 552.761576] gem_exec_whisper: starting subtest basic [ 655.078751] gem_exec_whisper: exiting, ret=0 [ 655.252303] kms_addfb_basic: executing [ 655.265677] kms_addfb_basic: starting subtest bad-pitch-128 [ 655.269005] kms_addfb_basic: exiting, ret=0 [ 655.437631] gem_exec_parse: executing [ 655.450582] gem_exec_parse: exiting, ret=0 [ 655.623675] kms_addfb_basic: executing [ 655.637837] kms_addfb_basic: starting subtest addfb25-Y-tiled [ 655.640251] kms_addfb_basic: exiting, ret=0 [ 655.807673] kms_addfb_basic: executing [ 655.821080] kms_addfb_basic: starting subtest small-bo [ 655.824422] kms_addfb_basic: exiting, ret=0 [ 656.001980] gem_sync: executing [ 656.015694] gem_sync: starting subtest basic-all [ 666.342082] gem_sync: exiting, ret=0 [ 666.516286] gem_storedw_loop: executing [ 666.529625] gem_storedw_loop: starting subtest basic-vebox [ 673.614990] gem_storedw_loop: exiting, ret=0 [ 674.238371] kms_pipe_crc_basic: executing [ 674.258169] kms_pipe_crc_basic: starting subtest nonblocking-crc-pipe-C [ 674.998203] kms_pipe_crc_basic: exiting, ret=0 [ 675.242388] kms_addfb_basic: executing [ 675.253164] kms_addfb_basic: starting subtest size-max [ 675.256306] kms_addfb_basic: exiting, ret=0 [ 675.459061] gem_cs_tlb: executing [ 675.469033] gem_cs_tlb: starting subtest basic-default [ 678.101106] gem_cs_tlb: exiting, ret=0 [ 678.442224] gem_exec_store: executing [ 678.452523] gem_exec_store: starting subtest basic-bsd [ 678.455661] gem_exec_store: exiting, ret=0 [ 678.644311] gem_ringfill: executing [ 678.654412] gem_ringfill: starting subtest basic-default [ 679.082364] gem_ringfill: exiting, ret=0 [ 679.275034] gem_exec_basic: executing [ 679.288982] gem_exec_basic: starting subtest gtt-vebox [ 679.292827] gem_exec_basic: exiting, ret=0 [ 679.460198] kms_addfb_basic: executing [ 679.474354] kms_addfb_basic: starting subtest bo-too-small [ 679.477611] kms_addfb_basic: exiting, ret=0 [ 679.681166] prime_self_import: executing [ 679.683349] prime_self_import: starting subtest basic-with_fd_dup [ 679.726440] prime_self_import: exiting, ret=0 [ 679.918574] gem_ctx_param_basic: executing [ 679.929109] gem_ctx_param_basic: starting subtest non-root-set [ 679.946186] gem_ctx_param_basic: exiting, ret=0 [ 680.149844] gem_storedw_loop: executing [ 680.161029] gem_storedw_loop: starting subtest basic-bsd [ 685.289008] gem_storedw_loop: exiting, ret=0