Bug 110875

Summary: [CI][DRMTIP] igt@gem_ctx_clone@vm - dmesg-warn - GEM_BUG_ON(i915_vma_is_pinned(vma))
Product: DRI Reporter: Lakshmi <lakshminarayana.vudum>
Component: DRM/IntelAssignee: Intel GFX Bugs mailing list <intel-gfx-bugs>
Status: RESOLVED DUPLICATE QA Contact: Intel GFX Bugs mailing list <intel-gfx-bugs>
Severity: normal    
Priority: medium CC: intel-gfx-bugs
Version: DRI git   
Hardware: Other   
OS: All   
Whiteboard: ReadyForDev
i915 platform: BYT, IVB i915 features: GEM/Other

Description Lakshmi 2019-06-10 10:38:07 UTC 
https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_302/fi-byt-j1900/igt@gem_ctx_clone@vm.html

<6> [71.158065] Console: switching to colour dummy device 80x25
<6> [71.158356] [IGT] gem_ctx_clone: executing
<5> [71.170269] Setting dangerous option reset - tainting kernel
<6> [71.182289] [IGT] gem_ctx_clone: starting subtest vm
<3> [71.223465] i915_vma_destroy:849 GEM_BUG_ON(i915_vma_is_pinned(vma))
<4> [71.223644] ------------[ cut here ]------------
<2> [71.223650] kernel BUG at drivers/gpu/drm/i915/i915_vma.c:849!
<4> [71.223772] invalid opcode: 0000 [#1] PREEMPT SMP PTI
<4> [71.223791] CPU: 0 PID: 264 Comm: kworker/0:2 Tainted: G     U            5.2.0-rc3-gf5df9c1b5bb5-drmtip_302+ #1
<4> [71.223817] Hardware name: GIGABYTE GB-BXBT-1900/MZBAYAB-00, BIOS F6 02/17/2015
<4> [71.223949] Workqueue: events gen6_ppgtt_cleanup_work [i915]
<4> [71.224065] RIP: 0010:i915_vma_destroy+0x204/0x3a0 [i915]
<4> [71.224087] Code: 2b 29 e8 d2 48 8b 35 43 db 1b 00 49 c7 c0 06 33 3d c0 b9 51 03 00 00 48 c7 c2 a0 de 37 c0 48 c7 c7 9f a3 2a c0 e8 1c ef ee d2 <0f> 0b 48 8d bb 10 02 00 00 e8 5e d5 22 d3 84 c0 75 3d 48 b8 00 01
<4> [71.224129] RSP: 0018:ffff95d2c019fe38 EFLAGS: 00010282
<4> [71.224145] RAX: 000000000000000c RBX: ffff93a0a11d0040 RCX: 0000000000000000
<4> [71.224163] RDX: 0000000000000001 RSI: 0000000000000008 RDI: ffff93a0bb097a38
<4> [71.224182] RBP: ffff93a0af059b08 R08: 000000000000007f R09: ffff93a0bb08e000
<4> [71.224200] R10: ffff95d2c019fe50 R11: ffff93a0bb097a38 R12: ffff93a0bba39780
<4> [71.224219] R13: ffff93a0bba3da00 R14: 0000000000000000 R15: 0000000000000000
<4> [71.224238] FS:  0000000000000000(0000) GS:ffff93a0bba00000(0000) knlGS:0000000000000000
<4> [71.224259] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [71.224275] CR2: 00007f09aff41228 CR3: 0000000128f26000 CR4: 00000000001006f0
<4> [71.224294] Call Trace:
<4> [71.224401]  gen6_ppgtt_cleanup_work+0x2e/0x40 [i915]
<4> [71.224424]  process_one_work+0x245/0x610
<4> [71.224444]  worker_thread+0x37/0x380
<4> [71.224460]  ? process_one_work+0x610/0x610
<4> [71.224476]  kthread+0x119/0x130
<4> [71.224490]  ? kthread_park+0x80/0x80
<4> [71.224507]  ret_from_fork+0x3a/0x50
<4> [71.224526] Modules linked in: snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 btusb btrtl btbcm btintel bluetooth coretemp snd_hda_intel snd_hda_codec crct10dif_pclmul crc32_pclmul snd_hwdep snd_hda_core ghash_clmulni_intel ecdh_generic ecc r8169 snd_pcm realtek lpc_ich prime_numbers i2c_hid
<0> [71.224611] Dumping ftrace buffer:
<0> [71.224624] ---------------------------------
<0> [71.224762] modprobe-270     1.... 8932546us : i915_gem_sanitize: 
<0> [71.224870] modprobe-270     1.... 8932687us : intel_gt_sanitize: 
<0> [71.224978] modprobe-270     1.... 8932691us : intel_gpu_reset: engine_mask=ff
<0> [71.225089] modprobe-270     1.... 8975938us : intel_gt_unpark: 
<0> [71.225196] modprobe-270     1.... 8976951us : __engine_unpark: rcs0
<0> [71.225304] modprobe-270     1.... 8976965us : xcs_resume: rcs0: ring:{HEAD:0000, TAIL:0000}
<0> [71.225423] modprobe-270     1.... 8977469us : __i915_request_commit: rcs0 fence 7:1
<0> [71.225540] modprobe-270     1d..1 8977611us : __i915_request_submit: rcs0 fence 7:1 -> current 0
<0> [71.225650] modprobe-270     1.... 8977740us : __engine_unpark: bcs0
<0> [71.225759] modprobe-270     1.... 8977742us : xcs_resume: bcs0: ring:{HEAD:0000, TAIL:0000}
<0> [71.225876] modprobe-270     1.... 8977839us : __i915_request_commit: bcs0 fence 9:1
<0> [71.225993] modprobe-270     1d..1 8977855us : __i915_request_submit: bcs0 fence 9:1 -> current 0
<0> [71.226103] modprobe-270     1.... 8977946us : __engine_unpark: vcs0
<0> [71.226209] modprobe-270     1.... 8977949us : xcs_resume: vcs0: ring:{HEAD:0000, TAIL:0000}
<0> [71.226329] modprobe-270     1.... 8978029us : __i915_request_commit: vcs0 fence b:1
<0> [71.226446] modprobe-270     1d..1 8978045us : __i915_request_submit: vcs0 fence b:1 -> current 0
<0> [71.226563] modprobe-270     1.... 8979976us : __i915_request_commit: rcs0 fence 7:2
<0> [71.226679] modprobe-270     1d..1 8980038us : __i915_request_submit: rcs0 fence 7:2 -> current 1
<0> [71.226807] modprobe-270     1.... 8980084us : i915_request_retire_upto: rcs0 fence 7:1, current 2
<0> [71.226928] modprobe-270     1.... 8980087us : i915_request_retire: rcs0 fence 7:1, current 2
<0> [71.227046] modprobe-270     1.... 8980090us : i915_request_retire: __retire_engine_request(rcs0) fence 7:1, current 2
<0> [71.227167] modprobe-270     1.... 8980279us : __i915_request_commit: bcs0 fence 9:2
<0> [71.227282] modprobe-270     1d..1 8980296us : __i915_request_submit: bcs0 fence 9:2 -> current 1
<0> [71.227398] modprobe-270     1.... 8980309us : i915_request_retire_upto: bcs0 fence 9:1, current 2
<0> [71.227516] modprobe-270     1.... 8980312us : i915_request_retire: bcs0 fence 9:1, current 2
<0> [71.227633] modprobe-270     1.... 8980315us : i915_request_retire: __retire_engine_request(bcs0) fence 9:1, current 2
<0> [71.227756] modprobe-270     1.... 8980371us : __i915_request_commit: vcs0 fence b:2
<0> [71.227873] modprobe-270     1d..1 8980388us : __i915_request_submit: vcs0 fence b:2 -> current 1
<0> [71.227991] modprobe-270     1.... 8980400us : i915_request_retire_upto: vcs0 fence b:1, current 2
<0> [71.228108] modprobe-270     1.... 8980402us : i915_request_retire: vcs0 fence b:1, current 2
<0> [71.228225] modprobe-270     1.... 8980405us : i915_request_retire: __retire_engine_request(vcs0) fence b:1, current 2
<0> [71.228347] modprobe-270     1.... 8980429us : i915_gem_wait_for_idle: flags=12 (locked), timeout=200, awake?=yes
<0> [71.228470] modprobe-270     1.... 8980507us : i915_request_retire: vcs0 fence b:2, current 2
<0> [71.228587] modprobe-270     1.... 8980510us : i915_request_retire: __retire_engine_request(vcs0) fence b:2, current 2
<0> [71.228716] modprobe-270     1.... 8980799us : __i915_request_commit: vcs0 fence b:3
<0> [71.228838] modprobe-270     1d..1 8980821us : __i915_request_submit: vcs0 fence b:3 -> current 2
<0> [71.228957] modprobe-270     1.... 8980914us : i915_request_retire: bcs0 fence 9:2, current 2
<0> [71.229075] modprobe-270     1.... 8980917us : i915_request_retire: __retire_engine_request(bcs0) fence 9:2, current 2
<0> [71.229197] modprobe-270     1.... 8980950us : __i915_request_commit: bcs0 fence 9:3
<0> [71.229312] modprobe-270     1d..1 8980966us : __i915_request_submit: bcs0 fence 9:3 -> current 2
<0> [71.229429] modprobe-270     1.... 8980997us : i915_request_retire: rcs0 fence 7:2, current 2
<0> [71.229545] modprobe-270     1.... 8981026us : i915_request_retire: __retire_engine_request(rcs0) fence 7:2, current 2
<0> [71.229666] modprobe-270     1.... 8981054us : __i915_request_commit: rcs0 fence 7:3
<0> [71.229784] modprobe-270     1d..1 8981070us : __i915_request_submit: rcs0 fence 7:3 -> current 2
<0> [71.229902] modprobe-270     1.... 8981101us : i915_request_retire: rcs0 fence 7:3, current 3
<0> [71.230020] modprobe-270     1.... 8981104us : i915_request_retire: __retire_engine_request(rcs0) fence 7:3, current 3
<0> [71.230136] modprobe-270     1.... 8981219us : __engine_park: rcs0
<0> [71.230249] modprobe-270     1.... 8981257us : i915_request_retire: bcs0 fence 9:3, current 3
<0> [71.230367] modprobe-270     1.... 8981259us : i915_request_retire: __retire_engine_request(bcs0) fence 9:3, current 3
<0> [71.230480] modprobe-270     1.... 8981266us : __engine_park: bcs0
<0> [71.230590] modprobe-270     1.... 8981287us : i915_request_retire: vcs0 fence b:3, current 3
<0> [71.230708] modprobe-270     1.... 8981290us : i915_request_retire: __retire_engine_request(vcs0) fence b:3, current 3
<0> [71.230822] modprobe-270     1.... 8981297us : __engine_park: vcs0
<0> [71.230926] modprobe-270     1.... 8981355us : intel_gt_park: 
<0> [71.231037] kms_fron-1019    1.... 47570796us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.231162] kms_fron-1019    1.... 47570801us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.231287] kms_fron-1019    1.... 47852072us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.231418] kms_fron-1019    1.... 47852077us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.231544] kms_flip-1021    1.... 48221253us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.231669] kms_flip-1021    1.... 48221257us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.231796] kms_flip-1021    1.... 48480016us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.231920] kms_flip-1021    1.... 48480019us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.232046] perf_pmu-1022    0.... 48650309us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.232171] perf_pmu-1022    0.... 48650312us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.232289] perf_pmu-1022    0.... 48653029us : intel_gt_unpark: 
<0> [71.232393] perf_pmu-1022    0.... 48654441us : intel_gt_park: 
<0> [71.232496] perf_pmu-1022    0.... 48656313us : intel_gt_unpark: 
<0> [71.232601] perf_pmu-1022    0.... 48656439us : intel_gt_park: 
<0> [71.232705] perf_pmu-1022    0.... 48656779us : intel_gt_unpark: 
<0> [71.232809] perf_pmu-1022    0.... 48656935us : intel_gt_park: 
<0> [71.232912] perf_pmu-1022    0.... 48657154us : intel_gt_unpark: 
<0> [71.233015] perf_pmu-1022    0.... 48657321us : intel_gt_park: 
<0> [71.233126] perf_pmu-1022    0.... 48658864us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.233250] perf_pmu-1022    0.... 48658866us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.233375] perf_pmu-1022    0.... 48660288us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.233502] perf_pmu-1022    0.... 48660290us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.233620] perf_pmu-1022    0.... 48660476us : intel_gt_unpark: 
<0> [71.233725] perf_pmu-1022    1.... 48662240us : intel_gt_park: 
<0> [71.233831] perf_pmu-1022    1.... 48662685us : intel_gt_unpark: 
<0> [71.233934] perf_pmu-1022    1.... 48662780us : intel_gt_park: 
<0> [71.234038] perf_pmu-1022    1.... 48662948us : intel_gt_unpark: 
<0> [71.234141] perf_pmu-1022    1.... 48663127us : intel_gt_park: 
<0> [71.234251] perf_pmu-1022    1.... 48664585us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.234376] perf_pmu-1022    1.... 48664588us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.234500] perf_pmu-1022    0.... 48685661us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.234625] perf_pmu-1022    0.... 48685664us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.234752] kms_mmap-1023    0.... 48859387us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.234879] kms_mmap-1023    0.... 48859390us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.235006] kms_mmap-1023    1.... 55235446us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.235132] kms_mmap-1023    1.... 55235450us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.235256] kms_vbla-1026    1.... 55680512us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.235380] kms_vbla-1026    1.... 55680515us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.235497] kms_vbla-1026    0.... 56048049us : intel_gt_unpark: 
<0> [71.235600] kms_vbla-1026    0.... 56048660us : intel_gt_park: 
<0> [71.235703] kms_vbla-1026    0.... 56049429us : intel_gt_unpark: 
<0> [71.235808] kms_vbla-1026    0.... 56050396us : __engine_unpark: rcs0
<0> [71.235922] kms_vbla-1026    0.... 56051142us : __i915_request_commit: rcs0 fence 7:4
<0> [71.236038] kms_vbla-1026    0d..1 56051197us : __i915_request_submit: rcs0 fence 7:4 -> current 3
<0> [71.236151] kworker/-264     0.... 69735152us : i915_reset: flags=1d
<0> [71.236256] kworker/-264     0.... 69735265us : intel_engine_stop_cs: rcs0
<0> [71.236361] kworker/-264     0.... 69735333us : __engine_unpark: bcs0
<0> [71.236465] kworker/-264     0.... 69735335us : intel_engine_stop_cs: bcs0
<0> [71.236570] kworker/-264     0.... 69735347us : __engine_unpark: vcs0
<0> [71.236673] kworker/-264     0.... 69735349us : intel_engine_stop_cs: vcs0
<0> [71.236781] kworker/-264     0.... 69735353us : intel_gpu_reset: engine_mask=ff
<0> [71.236889] kworker/-264     0d..1 69735371us : i915_reset_request: rcs0 rq=7:4, guilty? yes
<0> [71.237000] kworker/-264     0.... 69735419us : xcs_resume: rcs0: ring:{HEAD:0260, TAIL:0338}
<0> [71.237114] kworker/-264     0.... 69735548us : xcs_resume: bcs0: ring:{HEAD:0ed0, TAIL:0ed0}
<0> [71.237226] kworker/-264     0.... 69735612us : xcs_resume: vcs0: ring:{HEAD:0618, TAIL:0618}
<0> [71.237345] kworker/-264     0.... 69736222us : __i915_request_commit: bcs0 fence 9:4
<0> [71.237461] kworker/-264     0d..1 69736270us : __i915_request_submit: bcs0 fence 9:4 -> current 3
<0> [71.237580] kworker/-264     0.... 69736350us : __i915_request_commit: vcs0 fence b:4
<0> [71.237696] kworker/-264     0d..1 69736366us : __i915_request_submit: vcs0 fence b:4 -> current 3
<0> [71.237815] kms_vbla-1026    2.... 69785137us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=yes
<0> [71.237939] kms_vbla-1026    2.... 69785262us : i915_request_retire: vcs0 fence b:4, current 4
<0> [71.238056] kms_vbla-1026    2.... 69785266us : i915_request_retire: __retire_engine_request(vcs0) fence b:4, current 4
<0> [71.238169] kms_vbla-1026    2.... 69785324us : __engine_park: vcs0
<0> [71.238280] kms_vbla-1026    2.... 69785406us : i915_request_retire: bcs0 fence 9:4, current 4
<0> [71.238397] kms_vbla-1026    2.... 69785409us : i915_request_retire: __retire_engine_request(bcs0) fence 9:4, current 4
<0> [71.238511] kms_vbla-1026    2.... 69785415us : __engine_park: bcs0
<0> [71.238623] kms_vbla-1026    2.... 69785436us : i915_request_retire: rcs0 fence 7:4, current 4
<0> [71.238741] kms_vbla-1026    2.... 69785498us : i915_request_retire: __retire_engine_request(rcs0) fence 7:4, current 4
<0> [71.238865] kms_vbla-1026    2.... 69785736us : __i915_request_commit: rcs0 fence 7:5
<0> [71.238981] kms_vbla-1026    2d..1 69785783us : __i915_request_submit: rcs0 fence 7:5 -> current 4
<0> [71.239098] kms_vbla-1026    2.... 69785851us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=yes
<0> [71.239222] kms_vbla-1026    2.... 69785880us : i915_request_retire: rcs0 fence 7:5, current 5
<0> [71.239339] kms_vbla-1026    2.... 69785920us : i915_request_retire: __retire_engine_request(rcs0) fence 7:5, current 5
<0> [71.239452] kms_vbla-1026    2.... 69785945us : __engine_park: rcs0
<0> [71.239555] kms_vbla-1026    2.... 69785959us : intel_gt_park: 
<0> [71.239666] gem_prea-1034    3.... 70120255us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.239792] gem_prea-1034    3.... 70120259us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.239916] gem_prea-1034    3.... 70123072us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.240041] gem_prea-1034    3.... 70123076us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.240168] gem_ctx_-1035    3.... 70316936us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.240292] gem_ctx_-1035    3.... 70316939us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.240408] gem_ctx_-1035    3.... 70319109us : intel_gt_unpark: 
<0> [71.240511] gem_ctx_-1035    3.... 70319642us : intel_gt_park: 
<0> [71.240622] gem_ctx_-1035    0.... 70346380us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.240747] gem_ctx_-1035    0.... 70346384us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.240873] kms_colo-1037    1.... 70504360us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.240998] kms_colo-1037    1.... 70504363us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.241121] kms_colo-1037    0.... 70869925us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.241244] kms_colo-1037    0.... 70869929us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.241370] gem_ctx_-1044    2.... 71200830us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.241493] gem_ctx_-1044    2.... 71200834us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=no
<0> [71.241609] gem_ctx_-1044    2.... 71218077us : intel_gt_unpark: 
<0> [71.241711] gem_ctx_-1044    2.... 71218781us : __engine_unpark: rcs0
<0> [71.241822] gem_ctx_-1044    2.... 71218855us : __i915_request_commit: rcs0 fence 7:6
<0> [71.241937] gem_ctx_-1044    2d..1 71218875us : __i915_request_submit: rcs0 fence 7:6 -> current 5
<0> [71.242052] gem_ctx_-1044    0.... 71222064us : __i915_request_commit: rcs0 fence 7:7
<0> [71.242166] gem_ctx_-1044    0d..1 71222086us : __i915_request_submit: rcs0 fence 7:7 -> current 6
<0> [71.242282] gem_ctx_-1044    0.... 71222103us : i915_request_retire_upto: rcs0 fence 7:6, current 6
<0> [71.242398] gem_ctx_-1044    0.... 71222105us : i915_request_retire: rcs0 fence 7:6, current 6
<0> [71.242514] gem_ctx_-1044    0.... 71222147us : i915_request_retire: __retire_engine_request(rcs0) fence 7:6, current 6
<0> [71.242635] gem_ctx_-1044    0.... 71222622us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=yes
<0> [71.242759] gem_ctx_-1044    0.... 71223384us : i915_request_retire: rcs0 fence 7:7, current 7
<0> [71.242875] gem_ctx_-1044    0.... 71223404us : i915_request_retire: __retire_engine_request(rcs0) fence 7:7, current 7
<0> [71.242994] gem_ctx_-1044    0.... 71223447us : __i915_request_commit: rcs0 fence 7:8
<0> [71.243108] gem_ctx_-1044    0d..1 71223467us : __i915_request_submit: rcs0 fence 7:8 -> current 7
<0> [71.243224] gem_ctx_-1044    0.... 71223834us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=yes
<0> [71.243347] gem_ctx_-1044    0.... 71223863us : i915_request_retire: rcs0 fence 7:8, current 8
<0> [71.243463] gem_ctx_-1044    0.... 71223866us : i915_request_retire: __retire_engine_request(rcs0) fence 7:8, current 8
<0> [71.243575] gem_ctx_-1044    0.... 71223874us : __engine_park: rcs0
<0> [71.243677] gem_ctx_-1044    0.... 71223877us : intel_gt_park: 
<0> [71.243780] gem_ctx_-1044    0.... 71230674us : __engine_unpark: rcs0
<0> [71.243886] gem_ctx_-1044    0.... 71230736us : intel_gt_unpark: 
<0> [71.243996] gem_ctx_-1044    0.... 71231527us : __i915_request_commit: rcs0 fence 7:9
<0> [71.244110] gem_ctx_-1044    0d..1 71231573us : __i915_request_submit: rcs0 fence 7:9 -> current 8
<0> [71.244227] gem_ctx_-1044    0.... 71232389us : __i915_request_commit: rcs0 fence 7:10
<0> [71.244342] gem_ctx_-1044    0d..1 71232406us : __i915_request_submit: rcs0 fence 7:10 -> current 9
<0> [71.244458] gem_ctx_-1044    0.... 71232420us : i915_request_retire_upto: rcs0 fence 7:9, current 9
<0> [71.244574] gem_ctx_-1044    0.... 71232422us : i915_request_retire: rcs0 fence 7:9, current 9
<0> [71.244690] gem_ctx_-1044    0.... 71232852us : i915_request_retire: __retire_engine_request(rcs0) fence 7:9, current 10
<0> [71.244813] gem_ctx_-1044    0.... 71233414us : __i915_request_commit: rcs0 fence 7:11
<0> [71.244928] gem_ctx_-1044    0d..1 71233430us : __i915_request_submit: rcs0 fence 7:11 -> current 10
<0> [71.245045] gem_ctx_-1044    0.... 71233443us : i915_request_retire_upto: rcs0 fence 7:10, current 10
<0> [71.245165] gem_ctx_-1044    0.... 71233445us : i915_request_retire: rcs0 fence 7:10, current 10
<0> [71.245281] gem_ctx_-1044    0.... 71233449us : i915_request_retire: __retire_engine_request(rcs0) fence 7:10, current 10
<0> [71.245400] gem_ctx_-1044    0.... 71233869us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=yes
<0> [71.245522] gem_ctx_-1044    0.... 71233942us : i915_request_retire: rcs0 fence 7:11, current 11
<0> [71.245638] gem_ctx_-1044    0.... 71233958us : i915_request_retire: __retire_engine_request(rcs0) fence 7:11, current 11
<0> [71.245759] gem_ctx_-1044    0.... 71233991us : __i915_request_commit: rcs0 fence 7:12
<0> [71.245873] gem_ctx_-1044    0d..1 71234008us : __i915_request_submit: rcs0 fence 7:12 -> current 11
<0> [71.245992] gem_ctx_-1044    0.... 71234040us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=yes
<0> [71.246116] gem_ctx_-1044    0.... 71234064us : i915_request_retire: rcs0 fence 7:12, current 12
<0> [71.246231] gem_ctx_-1044    0.... 71234067us : i915_request_retire: __retire_engine_request(rcs0) fence 7:12, current 12
<0> [71.246344] gem_ctx_-1044    0.... 71234074us : __engine_park: rcs0
<0> [71.246446] gem_ctx_-1044    0.... 71234076us : intel_gt_park: 
<0> [71.246546] gem_ctx_-1044    0.... 71240080us : intel_gt_unpark: 
<0> [71.246647] gem_ctx_-1044    0.... 71240675us : __engine_unpark: rcs0
<0> [71.246758] gem_ctx_-1044    0.... 71240742us : __i915_request_commit: rcs0 fence 7:13
<0> [71.246872] gem_ctx_-1044    0d..1 71240761us : __i915_request_submit: rcs0 fence 7:13 -> current 12
<0> [71.246988] gem_ctx_-1044    0.... 71241269us : __i915_request_commit: rcs0 fence 7:14
<0> [71.247101] gem_ctx_-1044    0d..1 71241285us : __i915_request_submit: rcs0 fence 7:14 -> current 13
<0> [71.247218] gem_ctx_-1044    0.... 71241296us : i915_request_retire_upto: rcs0 fence 7:13, current 13
<0> [71.247334] gem_ctx_-1044    0.... 71241298us : i915_request_retire: rcs0 fence 7:13, current 13
<0> [71.247450] gem_ctx_-1044    0.... 71241303us : i915_request_retire: __retire_engine_request(rcs0) fence 7:13, current 13
<0> [71.247571] gem_ctx_-1044    0.... 71241682us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=yes
<0> [71.247696] gem_ctx_-1044    0.... 71241722us : i915_request_retire: rcs0 fence 7:14, current 14
<0> [71.247814] gem_ctx_-1044    0.... 71241737us : i915_request_retire: __retire_engine_request(rcs0) fence 7:14, current 14
<0> [71.247933] gem_ctx_-1044    0.... 71241770us : __i915_request_commit: rcs0 fence 7:15
<0> [71.248047] gem_ctx_-1044    0d..1 71241787us : __i915_request_submit: rcs0 fence 7:15 -> current 14
<0> [71.248162] gem_ctx_-1044    0.... 71241817us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=yes
<0> [71.248285] gem_ctx_-1044    0.... 71241842us : i915_request_retire: rcs0 fence 7:15, current 15
<0> [71.248400] gem_ctx_-1044    0.... 71241845us : i915_request_retire: __retire_engine_request(rcs0) fence 7:15, current 15
<0> [71.248512] gem_ctx_-1044    0.... 71241852us : __engine_park: rcs0
<0> [71.248614] gem_ctx_-1044    0.... 71241854us : intel_gt_park: 
<0> [71.248716] gem_ctx_-1044    0.... 71248622us : __engine_unpark: rcs0
<0> [71.248819] gem_ctx_-1044    0.... 71248634us : intel_gt_unpark: 
<0> [71.248929] gem_ctx_-1044    0.... 71248942us : __i915_request_commit: rcs0 fence 7:16
<0> [71.249043] gem_ctx_-1044    0d..1 71248961us : __i915_request_submit: rcs0 fence 7:16 -> current 15
<0> [71.249158] gem_ctx_-1044    0.... 71249583us : __i915_request_commit: rcs0 fence 7:17
<0> [71.249272] gem_ctx_-1044    0d..1 71249600us : __i915_request_submit: rcs0 fence 7:17 -> current 16
<0> [71.249388] gem_ctx_-1044    0.... 71249614us : i915_request_retire_upto: rcs0 fence 7:16, current 16
<0> [71.249504] gem_ctx_-1044    0.... 71249616us : i915_request_retire: rcs0 fence 7:16, current 16
<0> [71.249619] gem_ctx_-1044    0.... 71249752us : i915_request_retire: __retire_engine_request(rcs0) fence 7:16, current 17
<0> [71.249742] gem_ctx_-1044    0.... 71250311us : __i915_request_commit: rcs0 fence 7:18
<0> [71.249858] gem_ctx_-1044    0d..1 71250327us : __i915_request_submit: rcs0 fence 7:18 -> current 17
<0> [71.249974] gem_ctx_-1044    0.... 71250338us : i915_request_retire_upto: rcs0 fence 7:17, current 17
<0> [71.250091] gem_ctx_-1044    0.... 71250340us : i915_request_retire: rcs0 fence 7:17, current 17
<0> [71.250207] gem_ctx_-1044    0.... 71250343us : i915_request_retire: __retire_engine_request(rcs0) fence 7:17, current 17
<0> [71.250326] gem_ctx_-1044    0.... 71250718us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=yes
<0> [71.250448] gem_ctx_-1044    0.... 71250759us : i915_request_retire: rcs0 fence 7:18, current 18
<0> [71.250563] gem_ctx_-1044    0.... 71250773us : i915_request_retire: __retire_engine_request(rcs0) fence 7:18, current 18
<0> [71.250682] gem_ctx_-1044    0.... 71250805us : __i915_request_commit: rcs0 fence 7:19
<0> [71.250795] gem_ctx_-1044    0d..1 71250822us : __i915_request_submit: rcs0 fence 7:19 -> current 18
<0> [71.250912] gem_ctx_-1044    0.... 71250853us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever), awake?=yes
<0> [71.251035] gem_ctx_-1044    0.... 71250877us : i915_request_retire: rcs0 fence 7:19, current 19
<0> [71.251151] gem_ctx_-1044    0.... 71250880us : i915_request_retire: __retire_engine_request(rcs0) fence 7:19, current 19
<0> [71.251263] gem_ctx_-1044    0.... 71250926us : __engine_park: rcs0
<0> [71.251365] gem_ctx_-1044    0.... 71250928us : intel_gt_park: 
<0> [71.251475] kworker/-264     0.... 71256808us : i915_vma_destroy: i915_vma_destroy:849 GEM_BUG_ON(i915_vma_is_pinned(vma))
<0> [71.251504] ---------------------------------
<4> [71.256706] ---[ end trace 7a69ad3e584745a5 ]---
Comment 2 CI Bug Log 2019-06-10 10:41:10 UTC 
A CI Bug Log filter associated to this bug has been updated:

{- BYT IVB: igt@gem_ctx_clone@vm - dmesg-warn - igt@gem_ctx_clone@vm -}
{+ BYT IVB: igt@gem_ctx_clone@vm - dmesg-warn - GEM_BUG_ON(i915_vma_is_pinned(vma)) +}


  No new failures caught with the new filter
Comment 3 Chris Wilson 2019-06-10 10:43:20 UTC 

*** This bug has been marked as a duplicate of bug 110836 ***

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.