[57.247153] Initializing watchdogs [57.247197] /dev/watchdog0 [57.261708] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [57.265766] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.267849] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.271166] [001/132] (960s left) api_intel_bb (offset-control) [57.351162] Starting subtest: offset-control [57.364146] Subtest offset-control: SUCCESS (0.014s) [57.491815] [002/132] (960s left) kms_big_fb (x-tiled-8bpp-rotate-0) [57.583292] Starting subtest: x-tiled-8bpp-rotate-0 [58.862977] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.271s) [58.981896] [003/132] (958s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [59.054091] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [59.057506] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [59.121656] [004/132] (958s left) gem_mmap_gtt (bad-object) [59.174787] Subtest bad-object: SKIP (0.000s) [59.229913] [005/132] (958s left) kms_pm_rpm (fences) [60.937448] Starting subtest: fences [60.942274] Subtest fences: SKIP (0.000s) [61.494221] [006/132] (956s left) gem_ctx_persistence (smoketest) [61.560061] Starting subtest: smoketest [101.815834] Subtest smoketest: SUCCESS (40.206s) [101.922402] [007/132] (916s left) kms_vblank (query-busy-hang) [101.996939] Starting subtest: query-busy-hang [101.998874] Starting dynamic subtest: pipe-A-eDP-1 [128.665190] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.660s) [128.678992] Starting dynamic subtest: pipe-D-eDP-1 [143.665604] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.998s) [143.667932] Subtest query-busy-hang: SUCCESS (41.662s) [144.469619] [008/132] (873s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [144.521639] Starting subtest: etime-single-wait-for-submit-submitted [144.629530] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s) [144.715135] [009/132] (873s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [144.794197] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [151.732059] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.944s) [151.868600] [010/132] (866s left) syncobj_wait (reset-during-wait-for-submit) [151.925913] Starting subtest: reset-during-wait-for-submit [152.028843] Subtest reset-during-wait-for-submit: SUCCESS (0.102s) [152.105387] [011/132] (866s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [152.158161] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [152.261265] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s) [152.346178] [012/132] (865s left) gem_watchdog (default-virtual) [152.421757] Starting subtest: default-virtual [158.694276] Subtest default-virtual: SUCCESS (6.283s) [158.777813] [013/132] (859s left) kms_psr (pr-cursor-plane-move) [158.854074] Starting subtest: pr-cursor-plane-move [158.858868] Subtest pr-cursor-plane-move: SKIP (0.000s) [158.922375] [014/132] (859s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [159.006442] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [167.585934] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.584s) [167.708855] [015/132] (850s left) kms_big_fb (y-tiled-8bpp-rotate-90) [167.797615] Starting subtest: y-tiled-8bpp-rotate-90 [167.801700] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [167.884952] [016/132] (850s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [168.270651] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [169.065831] [017/132] (849s left) prime_busy (after-wait) [169.130634] Starting subtest: after-wait [169.132704] Starting dynamic subtest: rcs0 [169.162037] Dynamic subtest rcs0: SUCCESS (0.030s) [169.171955] Starting dynamic subtest: bcs0 [169.201921] Dynamic subtest bcs0: SUCCESS (0.039s) [169.210219] Starting dynamic subtest: vcs0 [169.243093] Dynamic subtest vcs0: SUCCESS (0.041s) [169.251678] Starting dynamic subtest: vcs1 [169.284087] Dynamic subtest vcs1: SUCCESS (0.041s) [169.291974] Starting dynamic subtest: vecs0 [169.325164] Dynamic subtest vecs0: SUCCESS (0.041s) [169.333761] Starting dynamic subtest: ccs0 [169.365306] Dynamic subtest ccs0: SUCCESS (0.040s) [169.474409] Subtest after-wait: SUCCESS (0.343s) [169.548456] [018/132] (848s left) kms_big_fb (4-tiled-64bpp-rotate-270) [169.635735] Starting subtest: 4-tiled-64bpp-rotate-270 [169.653394] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.018s) [169.764531] [019/132] (848s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [169.848696] Starting subtest: plane-lut1d-pre-ctm3x4 [169.972247] Starting dynamic subtest: pipe-A-plane-0 [170.116244] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [170.124226] Starting dynamic subtest: pipe-A-plane-1 [170.261122] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s) [170.270449] Starting dynamic subtest: pipe-A-plane-2 [170.394439] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s) [171.574778] Starting dynamic subtest: pipe-B-plane-0 [171.711456] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [171.719400] Starting dynamic subtest: pipe-B-plane-1 [171.844752] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s) [171.852575] Starting dynamic subtest: pipe-B-plane-2 [171.978261] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [173.206512] Starting dynamic subtest: pipe-C-plane-0 [173.334539] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [173.344296] Starting dynamic subtest: pipe-C-plane-1 [173.478373] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [173.490578] Starting dynamic subtest: pipe-C-plane-2 [173.622751] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [174.829903] Starting dynamic subtest: pipe-D-plane-0 [174.990070] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s) [174.998793] Starting dynamic subtest: pipe-D-plane-1 [175.145685] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [175.157177] Starting dynamic subtest: pipe-D-plane-2 [175.314090] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [175.601765] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.754s) [176.395819] [020/132] (842s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [176.492986] Starting subtest: fbc-modesetfrombusy [180.519318] Subtest fbc-modesetfrombusy: SUCCESS (4.032s) [181.680205] [021/132] (836s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [181.751983] Starting subtest: crc-primary-suspend-y-tiled-ccs [181.754350] Starting dynamic subtest: pipe-A-eDP-1 [181.763929] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [181.774255] Starting dynamic subtest: pipe-B-eDP-1 [181.782931] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [181.790274] Starting dynamic subtest: pipe-C-eDP-1 [181.798645] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [181.806202] Starting dynamic subtest: pipe-D-eDP-1 [181.814727] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [181.818897] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s) [183.948520] [022/132] (834s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [184.049005] Starting subtest: cursorB-vs-flipA-varying-size [184.053791] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s) [184.194209] [023/132] (834s left) gem_exec_balancer (semaphore) [184.263964] Starting subtest: semaphore [185.877624] Subtest semaphore: SUCCESS (1.612s) [186.193699] [024/132] (832s left) gem_exec_reloc (basic-write-gtt-active) [186.255634] Subtest basic-write-gtt-active: SKIP (0.000s) [186.328280] [025/132] (832s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [186.402136] Starting subtest: plane-all-transition-nonblocking-fencing [186.404321] Starting dynamic subtest: pipe-A-eDP-1 [188.896232] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [189.213791] Starting dynamic subtest: pipe-B-eDP-1 [192.488260] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.283s) [192.791556] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.388s) [193.609876] [026/132] (825s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [193.708778] Starting subtest: cursorA-vs-flipA-varying-size [204.861799] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.152s) [205.744069] [027/132] (813s left) gem_exec_reloc (basic-wc-cpu) [205.801052] Subtest basic-wc-cpu: SKIP (0.000s) [205.872601] [028/132] (812s left) gem_exec_schedule (preempt-engines) [205.940502] Starting subtest: preempt-engines [205.942829] Starting dynamic subtest: rcs0 [208.192805] Dynamic subtest rcs0: SUCCESS (2.261s) [208.203030] Starting dynamic subtest: bcs0 [210.505031] Dynamic subtest bcs0: SUCCESS (2.308s) [210.516489] Starting dynamic subtest: vcs0 [212.779774] Dynamic subtest vcs0: SUCCESS (2.273s) [212.791874] Starting dynamic subtest: vcs1 [215.064248] Dynamic subtest vcs1: SUCCESS (2.283s) [215.072555] Starting dynamic subtest: vecs0 [217.381408] Dynamic subtest vecs0: SUCCESS (2.315s) [217.392438] Starting dynamic subtest: ccs0 [219.674542] Dynamic subtest ccs0: SUCCESS (2.290s) [219.677506] Subtest preempt-engines: SUCCESS (13.743s) [219.978861] [029/132] (798s left) kms_cursor_crc (cursor-sliding-32x10) [220.120268] Starting subtest: cursor-sliding-32x10 [220.165465] Subtest cursor-sliding-32x10: SKIP (0.040s) [220.411496] [030/132] (798s left) kms_addfb_basic (invalid-set-prop-any) [220.460438] Starting subtest: invalid-set-prop-any [220.462373] Subtest invalid-set-prop-any: SUCCESS (0.000s) [220.559883] [031/132] (798s left) kms_flip (dpms-off-confusion-interruptible) [220.634336] Starting subtest: dpms-off-confusion-interruptible [220.636649] Starting dynamic subtest: A-eDP1 [229.336553] Dynamic subtest A-eDP1: SUCCESS (8.701s) [229.346234] Starting dynamic subtest: B-eDP1 [237.969141] Dynamic subtest B-eDP1: SUCCESS (8.631s) [237.980081] Starting dynamic subtest: C-eDP1 [246.593887] Dynamic subtest C-eDP1: SUCCESS (8.623s) [246.604902] Starting dynamic subtest: D-eDP1 [255.227943] Dynamic subtest D-eDP1: SUCCESS (8.631s) [255.234377] Subtest dpms-off-confusion-interruptible: SUCCESS (34.596s) [256.400151] [032/132] (762s left) gem_exec_fence (keep-in-fence) [256.585802] Starting subtest: keep-in-fence [256.588389] Starting dynamic subtest: rcs0 [256.639718] Dynamic subtest rcs0: SUCCESS (0.053s) [256.649645] Starting dynamic subtest: bcs0 [256.691721] Dynamic subtest bcs0: SUCCESS (0.050s) [256.702139] Starting dynamic subtest: vcs0 [257.881776] Dynamic subtest vcs0: SUCCESS (1.186s) [257.893034] Starting dynamic subtest: vcs1 [259.865502] Dynamic subtest vcs1: SUCCESS (1.981s) [259.876571] Starting dynamic subtest: vecs0 [261.849564] Dynamic subtest vecs0: SUCCESS (1.981s) [261.860891] Starting dynamic subtest: ccs0 [262.081716] Dynamic subtest ccs0: SUCCESS (0.231s) [262.084764] Subtest keep-in-fence: SUCCESS (5.496s) [263.913278] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true [263.917487] [033/132] (755s left) gem_exec_schedule (u-independent) [263.993686] Starting subtest: u-independent [263.995603] Starting dynamic subtest: rcs0 [265.817569] Dynamic subtest rcs0: SUCCESS (1.832s) [265.828872] Starting dynamic subtest: vcs0 [267.870446] Dynamic subtest vcs0: SUCCESS (2.050s) [267.881722] Starting dynamic subtest: vcs1 [269.855716] Dynamic subtest vcs1: SUCCESS (1.984s) [269.867187] Starting dynamic subtest: vecs0 [271.843268] Dynamic subtest vecs0: SUCCESS (1.985s) [271.854585] Starting dynamic subtest: ccs0 [273.816056] Dynamic subtest ccs0: SUCCESS (1.970s) [273.818729] Subtest u-independent: SUCCESS (9.832s) [274.112897] [034/132] (744s left) kms_addfb_basic (bad-pitch-999) [274.168449] Starting subtest: bad-pitch-999 [274.170768] Subtest bad-pitch-999: SUCCESS (0.000s) [274.307372] [035/132] (744s left) i915_drm_fdinfo (memory-info-purgeable) [274.346797] Starting subtest: memory-info-purgeable [274.349184] Starting dynamic subtest: smem0 [276.986587] Dynamic subtest smem0: SUCCESS (2.639s) [276.989233] Subtest memory-info-purgeable: SUCCESS (2.640s) [277.062918] [036/132] (742s left) kms_addfb_basic (bad-pitch-63) [277.132288] Starting subtest: bad-pitch-63 [277.134333] Subtest bad-pitch-63: SUCCESS (0.000s) [277.248835] [037/132] (741s left) syncobj_timeline (single-wait-signaled) [277.299950] Starting subtest: single-wait-signaled [277.302064] Subtest single-wait-signaled: SUCCESS (0.000s) [277.415803] [038/132] (741s left) kms_chamelium_edid (dp-edid-change-during-suspend) [277.779837] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [278.608585] [039/132] (740s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [278.682232] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [278.686306] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [278.752322] [040/132] (740s left) kms_psr (fbc-psr2-sprite-plane-onoff) [278.823062] Starting subtest: fbc-psr2-sprite-plane-onoff [278.825229] Starting dynamic subtest: eDP-1 [278.829191] Dynamic subtest eDP-1: SKIP (0.000s) [278.833219] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [278.895871] [041/132] (740s left) gem_workarounds (suspend-resume) [278.954506] Starting subtest: suspend-resume [295.197045] Subtest suspend-resume: SUCCESS (1.331s) [296.323260] [042/132] (724s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [296.421679] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [296.426259] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [296.522690] [043/132] (723s left) syncobj_wait (multi-wait-submitted-signaled) [296.571345] Starting subtest: multi-wait-submitted-signaled [296.573766] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [296.676324] [044/132] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [296.767780] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [296.772284] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [296.848951] [045/132] (723s left) gem_ctx_param (invalid-set-ringsize) [296.904303] Starting subtest: invalid-set-ringsize [296.906638] Subtest invalid-set-ringsize: SUCCESS (0.000s) [296.975410] [046/132] (723s left) kms_fbcon_fbt (fbc) [297.031326] Starting subtest: fbc [303.383490] Subtest fbc: SUCCESS (6.351s) [304.474547] [047/132] (716s left) sysfs_heartbeat_interval (invalid) [304.543628] Starting subtest: invalid [304.545993] Starting dynamic subtest: vecs0 [304.548277] Dynamic subtest vecs0: SUCCESS (0.000s) [304.557130] Starting dynamic subtest: ccs0 [304.559309] Dynamic subtest ccs0: SUCCESS (0.000s) [304.568700] Starting dynamic subtest: vcs0 [304.570666] Dynamic subtest vcs0: SUCCESS (0.000s) [304.579799] Starting dynamic subtest: bcs0 [304.582000] Dynamic subtest bcs0: SUCCESS (0.000s) [304.591140] Starting dynamic subtest: rcs0 [304.593348] Dynamic subtest rcs0: SUCCESS (0.000s) [304.602530] Starting dynamic subtest: vcs1 [304.604726] Dynamic subtest vcs1: SUCCESS (0.000s) [304.606911] Subtest invalid: SUCCESS (0.005s) [304.647932] [048/132] (716s left) kms_frontbuffer_tracking (psr-2p-rte) [304.742852] Starting subtest: psr-2p-rte [304.747306] Subtest psr-2p-rte: SKIP (0.000s) [304.849181] [049/132] (715s left) gem_pread (display) [304.929112] Subtest display: SKIP (0.000s) [304.993032] [050/132] (715s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [305.071573] Starting subtest: psr-rgb101010-draw-mmap-cpu [312.212901] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.013s) [312.318030] [051/132] (708s left) kms_cursor_crc (cursor-random-32x10) [312.477957] Starting subtest: cursor-random-32x10 [312.524292] Subtest cursor-random-32x10: SKIP (0.043s) [312.791218] [052/132] (708s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [312.866410] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [312.870683] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [312.978403] [053/132] (707s left) i915_getparams_basic (basic-eu-total) [313.043734] Starting subtest: basic-eu-total [313.048013] Subtest basic-eu-total: SUCCESS (0.000s) [313.148993] [054/132] (707s left) core_getversion (basic) [313.188735] Starting subtest: basic [313.192398] Subtest basic: SUCCESS (0.000s) [313.255900] [055/132] (707s left) kms_joiner (basic-force-ultra-joiner) [313.338305] Starting subtest: basic-force-ultra-joiner [313.341486] Subtest basic-force-ultra-joiner: SKIP (0.000s) [313.406269] [056/132] (707s left) kms_psr (fbc-pr-primary-mmap-gtt) [313.474391] Starting subtest: fbc-pr-primary-mmap-gtt [313.478042] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [313.549977] [057/132] (707s left) kms_lease (lease-get) [313.618099] Starting subtest: lease-get [313.619993] Starting dynamic subtest: pipe-A-eDP-1 [313.622015] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [313.631170] Starting dynamic subtest: pipe-B-eDP-1 [313.632761] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [313.640639] Starting dynamic subtest: pipe-C-eDP-1 [313.642251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [313.650164] Starting dynamic subtest: pipe-D-eDP-1 [313.651779] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [313.653375] Subtest lease-get: SUCCESS (0.009s) [313.723309] [058/132] (707s left) gem_exec_balancer (bonded-sync) [313.792647] Starting subtest: bonded-sync [313.796400] Subtest bonded-sync: SKIP (0.000s) [314.112611] [059/132] (707s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [314.202056] Starting subtest: psr-2p-primscrn-cur-indfb-move [314.206402] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [314.312177] [060/132] (706s left) gem_mmap_offset (bad-object) [314.374564] Starting subtest: bad-object [314.376911] Subtest bad-object: SUCCESS (0.001s) [314.481635] [061/132] (706s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [314.568945] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [314.573556] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [314.655484] [062/132] (706s left) gem_render_copy (yf-tiled-to-vebox-linear) [314.721905] Starting subtest: yf-tiled-to-vebox-linear [314.726426] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [314.913615] [063/132] (706s left) kms_flip (flip-vs-dpms-on-nop) [315.002147] Starting subtest: flip-vs-dpms-on-nop [315.004524] Starting dynamic subtest: A-eDP1 [316.892719] Dynamic subtest A-eDP1: SUCCESS (1.872s) [316.903869] Starting dynamic subtest: B-eDP1 [318.848404] Dynamic subtest B-eDP1: SUCCESS (1.938s) [318.862559] Starting dynamic subtest: C-eDP1 [320.690529] Dynamic subtest C-eDP1: SUCCESS (1.828s) [320.701840] Starting dynamic subtest: D-eDP1 [322.525668] Dynamic subtest D-eDP1: SUCCESS (1.825s) [322.531735] Subtest flip-vs-dpms-on-nop: SUCCESS (7.476s) [323.724307] [064/132] (697s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [323.802902] Starting subtest: async-flip-with-page-flip-events-tiled [324.180719] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [326.905440] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.714s) [326.917067] Starting dynamic subtest: pipe-A-eDP-1-4 [329.097231] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.186s) [329.106837] Starting dynamic subtest: pipe-A-eDP-1-4 [331.112386] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s) [331.124301] Starting dynamic subtest: pipe-A-eDP-1-x [333.284539] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.168s) [333.653173] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [336.453965] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.803s) [336.465652] Starting dynamic subtest: pipe-B-eDP-1-4 [338.642138] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [338.652696] Starting dynamic subtest: pipe-B-eDP-1-4 [340.654258] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.011s) [340.666902] Starting dynamic subtest: pipe-B-eDP-1-x [342.833927] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s) [343.214789] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [345.991583] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.784s) [346.003450] Starting dynamic subtest: pipe-C-eDP-1-4 [348.155690] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s) [348.166987] Starting dynamic subtest: pipe-C-eDP-1-4 [350.166409] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [350.179032] Starting dynamic subtest: pipe-C-eDP-1-x [352.368496] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.200s) [352.732085] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [355.523998] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.797s) [355.535997] Starting dynamic subtest: pipe-D-eDP-1-4 [357.698162] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [357.709710] Starting dynamic subtest: pipe-D-eDP-1-4 [359.709632] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [359.721526] Starting dynamic subtest: pipe-D-eDP-1-x [361.888791] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [361.891127] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.050s) [363.108536] [065/132] (658s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [363.185183] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [367.174998] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.992s) [368.320291] [066/132] (653s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [368.443756] Starting subtest: 2x-long-flip-vs-cursor-legacy [368.448434] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [368.590727] [067/132] (652s left) gem_create (create-ext-placement-each) [368.753620] Starting subtest: create-ext-placement-each [368.756165] Subtest create-ext-placement-each: SUCCESS (0.000s) [368.849965] [068/132] (652s left) kms_psr (psr-sprite-plane-onoff) [368.927605] Starting subtest: psr-sprite-plane-onoff [368.929929] Starting dynamic subtest: eDP-1 [370.743136] Dynamic subtest eDP-1: SUCCESS (1.814s) [370.745515] Subtest psr-sprite-plane-onoff: SUCCESS (1.815s) [371.558944] [069/132] (649s left) gen9_exec_parse (bb-start-out) [371.617264] Subtest bb-start-out: SKIP (0.000s) [371.684911] [070/132] (649s left) syncobj_timeline (invalid-transfer-illegal-handle) [371.744760] Starting subtest: invalid-transfer-illegal-handle [371.746973] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [371.855177] [071/132] (649s left) kms_content_protection (srm) [371.988661] Starting subtest: srm [371.995266] Subtest srm: SKIP (0.004s) [372.117906] [072/132] (649s left) kms_big_fb (linear-32bpp-rotate-270) [372.230395] Starting subtest: linear-32bpp-rotate-270 [372.250361] Subtest linear-32bpp-rotate-270: SKIP (0.019s) [372.369528] [073/132] (649s left) gem_exec_reloc (basic-concurrent16) [372.428783] Subtest basic-concurrent16: SKIP (0.000s) [372.506950] [074/132] (649s left) syncobj_basic (bad-create-flags) [372.566089] Starting subtest: bad-create-flags [372.568067] Subtest bad-create-flags: SUCCESS (0.000s) [372.670646] [075/132] (649s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [372.780583] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [382.044194] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.258s) [382.903560] [076/132] (638s left) kms_vblank (query-forked-hang) [382.988867] Starting subtest: query-forked-hang [382.991135] Starting dynamic subtest: pipe-A-eDP-1 [409.618509] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.623s) [409.632648] Starting dynamic subtest: pipe-D-eDP-1 [434.606066] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.989s) [434.608315] Subtest query-forked-hang: SUCCESS (51.616s) [435.459384] [077/132] (586s left) gem_mmap_gtt (coherency) [435.524055] Subtest coherency: SKIP (0.000s) [435.592915] [078/132] (586s left) perf_pmu (module-unload)