[57.013813] Initializing watchdogs [57.013859] /dev/watchdog0 [57.028249] [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.032129] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.034342] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.037758] [001/133] (960s left) syncobj_timeline (wait-all-for-submit-snapshot) [57.123063] Starting subtest: wait-all-for-submit-snapshot [57.204897] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [57.277058] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [57.368766] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [57.372766] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [57.467005] [003/133] (960s left) gem_mmap_wc (write-read) [57.525787] Subtest write-read: SKIP (0.000s) [57.593670] [004/133] (960s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [57.669289] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [57.673866] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [58.798278] [005/133] (958s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [58.853948] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [58.961765] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s) [59.031729] [006/133] (958s left) perf_pmu (rc6) [59.069550] Starting subtest: rc6 [59.071960] Starting dynamic subtest: gt0 [65.497918] Dynamic subtest gt0: SUCCESS (6.365s) [65.506759] Starting dynamic subtest: runtime-pm-gt0 [73.228479] Dynamic subtest runtime-pm-gt0: SUCCESS (7.790s) [73.238708] Starting dynamic subtest: runtime-pm-long-gt0 [85.725922] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.495s) [85.734971] Starting dynamic subtest: other-idle-gt0 [92.067739] Dynamic subtest other-idle-gt0: SUCCESS (6.340s) [92.082756] Starting dynamic subtest: gt1 [98.408717] Dynamic subtest gt1: SUCCESS (6.339s) [98.419864] Starting dynamic subtest: runtime-pm-gt1 [105.899104] Dynamic subtest runtime-pm-gt1: SUCCESS (7.489s) [105.910666] Starting dynamic subtest: runtime-pm-long-gt1 [118.333987] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.434s) [118.344601] Starting dynamic subtest: other-idle-gt1 [124.675865] Dynamic subtest other-idle-gt1: SUCCESS (6.341s) [124.678694] Subtest rc6: SUCCESS (65.604s) [125.814378] [007/133] (891s left) syncobj_eventfd (timeline-wait-signaled) [125.865761] Starting subtest: timeline-wait-signaled [125.868056] Subtest timeline-wait-signaled: SUCCESS (0.000s) [125.924198] [008/133] (891s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [126.005597] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [126.009266] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [126.076462] [009/133] (891s left) gem_exec_params (no-bsd) [126.133072] Starting subtest: no-bsd [126.135214] Subtest no-bsd: SUCCESS (0.002s) [127.257094] [010/133] (890s left) kms_getfb (getfb-handle-valid) [127.323849] Starting subtest: getfb-handle-valid [127.326167] Subtest getfb-handle-valid: SUCCESS (0.000s) [127.396472] [011/133] (890s left) kms_chamelium_color (ctm-0-50) [127.466637] Subtest ctm-0-50: SKIP (0.000s) [127.510841] [012/133] (890s left) gem_userptr_blits (nohangcheck) [127.585971] Starting subtest: nohangcheck [127.830266] Subtest nohangcheck: SUCCESS (0.241s) [127.919551] [013/133] (890s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [127.996401] Starting subtest: pr-overlay-plane-move-continuous-sf [128.000699] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [128.037571] [014/133] (889s left) gem_spin_batch (resubmit-new-all) [128.103040] Starting subtest: resubmit-new-all [128.105420] Starting dynamic subtest: rcs0 [128.117551] Dynamic subtest rcs0: SUCCESS (0.017s) [128.129269] Starting dynamic subtest: bcs0 [128.131189] Dynamic subtest bcs0: SUCCESS (0.010s) [128.138908] Starting dynamic subtest: vcs0 [128.141233] Dynamic subtest vcs0: SUCCESS (0.008s) [128.148688] Starting dynamic subtest: vcs1 [128.150688] Dynamic subtest vcs1: SUCCESS (0.007s) [128.158154] Starting dynamic subtest: vecs0 [128.160542] Dynamic subtest vecs0: SUCCESS (0.007s) [128.168073] Starting dynamic subtest: ccs0 [128.170234] Dynamic subtest ccs0: SUCCESS (0.007s) [128.172405] Subtest resubmit-new-all: SUCCESS (0.058s) [129.249099] [015/133] (888s left) gem_exec_schedule (u-independent) [129.327353] Starting subtest: u-independent [129.329688] Starting dynamic subtest: rcs0 [131.200167] Dynamic subtest rcs0: SUCCESS (1.881s) [131.211722] Starting dynamic subtest: vcs0 [133.257605] Dynamic subtest vcs0: SUCCESS (2.056s) [133.268818] Starting dynamic subtest: vcs1 [135.257799] Dynamic subtest vcs1: SUCCESS (1.999s) [135.269026] Starting dynamic subtest: vecs0 [137.234837] Dynamic subtest vecs0: SUCCESS (1.976s) [137.245537] Starting dynamic subtest: ccs0 [139.197866] Dynamic subtest ccs0: SUCCESS (1.961s) [139.200542] Subtest u-independent: SUCCESS (9.878s) [139.475374] [016/133] (878s left) syncobj_timeline (invalid-query-illegal-handle) [139.541658] Starting subtest: invalid-query-illegal-handle [139.544070] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [139.604172] [017/133] (878s left) gem_partial_pwrite_pread (reads-display) [139.663480] Subtest reads-display: SKIP (0.000s) [139.736794] [018/133] (878s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [139.786673] Starting subtest: multi-wait-all-for-submit-submitted-signaled [139.890449] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s) [139.963581] [019/133] (878s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [140.044377] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [140.048905] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [141.160227] [020/133] (877s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [141.238120] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [141.242463] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [141.286856] [021/133] (877s left) kms_color_pipeline (plane-lut1d-lut1d) [141.368096] Starting subtest: plane-lut1d-lut1d [141.548678] Starting dynamic subtest: pipe-A-plane-0 [141.693308] Dynamic subtest pipe-A-plane-0: SUCCESS (0.145s) [141.702620] Starting dynamic subtest: pipe-A-plane-1 [141.826639] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [141.835787] Starting dynamic subtest: pipe-A-plane-2 [141.959962] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s) [143.158130] Starting dynamic subtest: pipe-B-plane-0 [143.295465] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [143.308018] Starting dynamic subtest: pipe-B-plane-1 [143.428638] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s) [143.437307] Starting dynamic subtest: pipe-B-plane-2 [143.573573] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s) [144.791671] Starting dynamic subtest: pipe-C-plane-0 [144.941434] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [144.958040] Starting dynamic subtest: pipe-C-plane-1 [145.073437] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s) [145.085254] Starting dynamic subtest: pipe-C-plane-2 [145.207051] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s) [146.429937] Starting dynamic subtest: pipe-D-plane-0 [146.557345] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [146.565446] Starting dynamic subtest: pipe-D-plane-1 [146.689957] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [146.698121] Starting dynamic subtest: pipe-D-plane-2 [146.836766] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [147.130776] Subtest plane-lut1d-lut1d: SUCCESS (5.760s) [147.895573] [022/133] (870s left) kms_psr (fbc-psr2-cursor-plane-move) [147.971685] Starting subtest: fbc-psr2-cursor-plane-move [147.973891] Starting dynamic subtest: eDP-1 [147.978033] Dynamic subtest eDP-1: SKIP (0.000s) [147.982151] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s) [148.020629] [023/133] (870s left) gem_exec_schedule (preempt-contexts) [148.089291] Starting subtest: preempt-contexts [148.091431] Starting dynamic subtest: rcs0 [148.134282] Dynamic subtest rcs0: SUCCESS (0.053s) [148.145399] Starting dynamic subtest: bcs0 [148.200716] Dynamic subtest bcs0: SUCCESS (0.066s) [148.208722] Starting dynamic subtest: vcs0 [148.257787] Dynamic subtest vcs0: SUCCESS (0.056s) [148.266027] Starting dynamic subtest: vcs1 [148.297972] Dynamic subtest vcs1: SUCCESS (0.039s) [148.306775] Starting dynamic subtest: vecs0 [148.339230] Dynamic subtest vecs0: SUCCESS (0.041s) [148.347970] Starting dynamic subtest: ccs0 [148.382593] Dynamic subtest ccs0: SUCCESS (0.043s) [148.384916] Subtest preempt-contexts: SUCCESS (0.301s) [150.269117] [024/133] (868s left) i915_drm_fdinfo (most-busy-idle-check-all) [150.317404] Starting subtest: most-busy-idle-check-all [150.319696] Starting dynamic subtest: rcs0 [150.324295] Dynamic subtest rcs0: SKIP (0.003s) [150.336245] Starting dynamic subtest: bcs0 [150.340898] Dynamic subtest bcs0: SKIP (0.000s) [150.348561] Starting dynamic subtest: vcs0 [150.352774] Dynamic subtest vcs0: SKIP (0.000s) [150.360076] Starting dynamic subtest: vcs1 [150.364231] Dynamic subtest vcs1: SKIP (0.000s) [150.371450] Starting dynamic subtest: vecs0 [150.375637] Dynamic subtest vecs0: SKIP (0.000s) [150.382873] Starting dynamic subtest: ccs0 [150.387080] Dynamic subtest ccs0: SKIP (0.000s) [150.391237] Subtest most-busy-idle-check-all: SKIP (0.007s) [150.425131] [025/133] (868s left) gem_exec_schedule (fifo) [150.520347] Starting subtest: fifo [150.522523] Starting dynamic subtest: rcs0 [150.667433] Dynamic subtest rcs0: SUCCESS (0.152s) [150.678071] Starting dynamic subtest: vcs0 [150.770874] Dynamic subtest vcs0: SUCCESS (0.103s) [150.781679] Starting dynamic subtest: vcs1 [150.872385] Dynamic subtest vcs1: SUCCESS (0.100s) [150.885940] Starting dynamic subtest: vecs0 [150.971373] Dynamic subtest vecs0: SUCCESS (0.098s) [150.982508] Starting dynamic subtest: ccs0 [151.086279] Dynamic subtest ccs0: SUCCESS (0.114s) [151.088802] Subtest fifo: SUCCESS (0.572s) [152.313984] [026/133] (866s left) gem_close_race (multigpu-basic-process) [152.379809] Starting subtest: multigpu-basic-process [152.384472] Subtest multigpu-basic-process: SKIP (0.000s) [152.578581] [027/133] (865s left) gem_exec_suspend (basic-s4-devices) [152.647043] Starting subtest: basic-S4-devices [152.649508] Starting dynamic subtest: smem [164.223702] Dynamic subtest smem: SUCCESS (11.573s) [164.226794] Subtest basic-S4-devices: SUCCESS (11.575s) [172.400896] [028/133] (854s left) kms_joiner (basic-max-non-joiner) [172.513766] Starting subtest: basic-max-non-joiner [172.518361] Subtest basic-max-non-joiner: SKIP (0.000s) [172.554875] [029/133] (854s left) fbdev (info) [172.589693] Starting subtest: info [172.591990] Subtest info: SUCCESS (0.000s) [172.632987] [030/133] (854s left) kms_pm_rpm (pc8-residency) [174.357936] Starting subtest: pc8-residency [174.363100] Subtest pc8-residency: SKIP (0.000s) [174.900266] [031/133] (851s left) gem_pxp (create-valid-protected-context) [175.030189] Starting subtest: create-valid-protected-context [175.032715] Subtest create-valid-protected-context: SUCCESS (0.002s) [175.111318] [032/133] (851s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [175.209818] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf [175.212233] Starting dynamic subtest: pipe-A-eDP-1 [175.284670] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s) [175.294286] Starting dynamic subtest: pipe-B-eDP-1 [176.390919] Dynamic subtest pipe-B-eDP-1: SKIP (1.104s) [176.395545] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.185s) [177.563808] [033/133] (849s left) i915_pm_rps (engine-order) [177.620965] Starting subtest: engine-order [183.961275] Subtest engine-order: SUCCESS (6.340s) [184.046626] [034/133] (842s left) kms_cursor_crc (cursor-sliding-256x256) [184.347434] Starting subtest: cursor-sliding-256x256 [184.349851] Starting dynamic subtest: pipe-A-eDP-1 [187.575430] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.224s) [187.610369] Starting dynamic subtest: pipe-D-eDP-1 [191.572479] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.976s) [191.574918] Subtest cursor-sliding-256x256: SUCCESS (7.225s) [192.438189] [035/133] (834s left) i915_query (query-topology-matches-eu-total) [192.488103] Starting subtest: query-topology-matches-eu-total [192.490093] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [192.555946] [036/133] (834s left) gem_exec_balancer (bonded-false-hang) [192.800287] Starting subtest: bonded-false-hang [192.805234] Subtest bonded-false-hang: SKIP (0.000s) [192.868954] [037/133] (834s left) kms_psr (fbc-psr2-sprite-render) [192.952219] Starting subtest: fbc-psr2-sprite-render [192.954612] Starting dynamic subtest: eDP-1 [192.958838] Dynamic subtest eDP-1: SKIP (0.000s) [192.963069] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [193.008384] [038/133] (833s left) gem_exec_reloc (basic-gtt-cpu) [193.065842] Subtest basic-gtt-cpu: SKIP (0.000s) [193.141029] [039/133] (833s left) kms_draw_crc (draw-method-blt) [193.229399] Starting subtest: draw-method-blt [193.231777] Starting dynamic subtest: xrgb8888-untiled [193.463456] Dynamic subtest xrgb8888-untiled: SUCCESS (0.234s) [193.474273] Starting dynamic subtest: rgb565-untiled [193.685602] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [193.696840] Starting dynamic subtest: xrgb2101010-untiled [193.896533] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s) [193.906318] Starting dynamic subtest: xbgr16161616f-untiled [194.153992] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.254s) [194.169773] Starting dynamic subtest: xrgb8888-xtiled [194.274356] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [194.284753] Starting dynamic subtest: rgb565-xtiled [194.396907] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [194.406778] Starting dynamic subtest: xrgb2101010-xtiled [194.507622] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.109s) [194.517605] Starting dynamic subtest: xbgr16161616f-xtiled [194.618858] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s) [194.631303] Starting dynamic subtest: xrgb8888-4tiled [194.729780] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s) [194.740095] Starting dynamic subtest: rgb565-4tiled [194.852183] Dynamic subtest rgb565-4tiled: SUCCESS (0.120s) [194.864043] Starting dynamic subtest: xrgb2101010-4tiled [194.952055] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.100s) [194.961679] Starting dynamic subtest: xbgr16161616f-4tiled [195.063068] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s) [195.064998] Subtest draw-method-blt: SUCCESS (1.835s) [195.143514] [040/133] (831s left) i915_suspend (basic-s2idle-without-i915) [195.175926] Starting subtest: basic-s2idle-without-i915 [215.933841] Subtest basic-s2idle-without-i915: SUCCESS (5.485s) [216.039853] [041/133] (811s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [216.121656] Starting subtest: blocking-absolute-wf_vblank-interruptible [216.124004] Starting dynamic subtest: A-eDP1 [224.838104] Dynamic subtest A-eDP1: SUCCESS (8.680s) [224.849823] Starting dynamic subtest: B-eDP1 [233.570751] Dynamic subtest B-eDP1: SUCCESS (8.731s) [233.582013] Starting dynamic subtest: C-eDP1 [242.293115] Dynamic subtest C-eDP1: SUCCESS (8.710s) [242.304909] Starting dynamic subtest: D-eDP1 [251.031487] Dynamic subtest D-eDP1: SUCCESS (8.730s) [251.034387] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.862s) [252.184683] [042/133] (774s left) perf (invalid-oa-exponent) [252.269850] Starting subtest: invalid-oa-exponent [252.284639] Subtest invalid-oa-exponent: SUCCESS (0.014s) [252.332080] [043/133] (774s left) api_intel_bb (misplaced-blitter) [252.396980] Starting subtest: misplaced-blitter [252.406281] Subtest misplaced-blitter: SUCCESS (0.010s) [252.496594] [044/133] (774s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [252.555920] Starting subtest: x-tiled-to-vebox-yf-tiled [252.560127] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [252.714449] [045/133] (774s left) gem_eio (wait-wedge-immediate) [252.857056] Starting subtest: wait-wedge-immediate [254.531200] Subtest wait-wedge-immediate: SUCCESS (1.674s) [254.631827] [046/133] (772s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [254.729940] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [261.335300] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.608s) [261.435305] [047/133] (765s left) kms_vrr (flip-basic) [261.505575] Starting subtest: flip-basic [261.511621] Subtest flip-basic: SKIP (0.000s) [261.555207] [048/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [261.654554] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [262.677692] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.023s) [262.790359] [049/133] (764s left) gem_exec_schedule (u-submit-late-slice) [262.864895] Starting subtest: u-submit-late-slice [262.866887] Starting dynamic subtest: rcs0 [262.894296] Dynamic subtest rcs0: SUCCESS (0.037s) [262.907618] Starting dynamic subtest: bcs0 [262.929436] Dynamic subtest bcs0: SUCCESS (0.035s) [262.939605] Starting dynamic subtest: vcs0 [262.960058] Dynamic subtest vcs0: SUCCESS (0.030s) [262.971191] Starting dynamic subtest: vcs1 [262.992845] Dynamic subtest vcs1: SUCCESS (0.032s) [263.002565] Starting dynamic subtest: vecs0 [263.027179] Dynamic subtest vecs0: SUCCESS (0.034s) [263.036898] Starting dynamic subtest: ccs0 [263.064719] Dynamic subtest ccs0: SUCCESS (0.037s) [263.066557] Subtest u-submit-late-slice: SUCCESS (0.209s) [264.543604] [050/133] (762s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [264.630349] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [265.298432] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s) [265.436744] [051/133] (762s left) kms_chamelium_hpd (dp-hpd-fast) [265.811912] Subtest dp-hpd-fast: SKIP (0.000s) [266.630935] [052/133] (760s left) perf_pmu (frequency) [266.672161] Starting subtest: frequency [266.674561] Starting dynamic subtest: gt0 [268.829208] Dynamic subtest gt0: SUCCESS (2.151s) [268.841004] Starting dynamic subtest: idle-gt0 [269.335200] Dynamic subtest idle-gt0: SUCCESS (0.505s) [269.347264] Starting dynamic subtest: gt1 [273.489273] Dynamic subtest gt1: SUCCESS (4.149s) [273.500449] Starting dynamic subtest: idle-gt1 [274.024022] Dynamic subtest idle-gt1: SUCCESS (0.534s) [274.026868] Subtest frequency: SUCCESS (7.354s) [274.100663] [053/133] (753s left) gem_ctx_persistence (processes) [274.166203] Starting subtest: processes [275.484292] Subtest processes: SUCCESS (1.318s) [275.538091] [054/133] (752s left) prime_vgem (fence-wait) [275.666244] Starting subtest: fence-wait [275.668620] Starting dynamic subtest: rcs0 [276.715111] Dynamic subtest rcs0: SUCCESS (1.047s) [276.731911] Starting dynamic subtest: bcs0 [277.776732] Dynamic subtest bcs0: SUCCESS (1.058s) [277.789139] Starting dynamic subtest: vcs0 [278.820345] Dynamic subtest vcs0: SUCCESS (1.042s) [278.832332] Starting dynamic subtest: vcs1 [279.861691] Dynamic subtest vcs1: SUCCESS (1.039s) [279.873936] Starting dynamic subtest: vecs0 [280.901018] Dynamic subtest vecs0: SUCCESS (1.038s) [280.913444] Starting dynamic subtest: ccs0 [281.946627] Dynamic subtest ccs0: SUCCESS (1.043s) [281.949573] Subtest fence-wait: SUCCESS (6.279s) [282.036996] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true [282.040817] [055/133] (745s left) perf_pmu (busy-idle-check-all) [282.086521] Starting subtest: busy-idle-check-all [282.088925] Starting dynamic subtest: rcs0 [282.742946] Dynamic subtest rcs0: SUCCESS (0.656s) [282.756230] Starting dynamic subtest: bcs0 [283.399388] Dynamic subtest bcs0: SUCCESS (0.654s) [283.412789] Starting dynamic subtest: vcs0 [284.514065] Dynamic subtest vcs0: SUCCESS (1.111s) [284.527452] Starting dynamic subtest: vcs1 [286.498084] Dynamic subtest vcs1: SUCCESS (1.981s) [286.511062] Starting dynamic subtest: vecs0 [288.483667] Dynamic subtest vecs0: SUCCESS (1.983s) [288.496307] Starting dynamic subtest: ccs0 [289.141140] Dynamic subtest ccs0: SUCCESS (0.656s) [289.143927] Subtest busy-idle-check-all: SUCCESS (7.054s) [289.220487] [056/133] (738s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [289.299729] Starting subtest: plane-downscale-factor-0-5-with-modifiers [289.302032] Starting dynamic subtest: pipe-A [289.319719] Dynamic subtest pipe-A: SKIP (0.016s) [289.330115] Starting dynamic subtest: pipe-B [289.374926] Dynamic subtest pipe-B: SKIP (0.055s) [289.385383] Starting dynamic subtest: pipe-C [289.414817] Dynamic subtest pipe-C: SKIP (0.039s) [289.427126] Starting dynamic subtest: pipe-D [289.447923] Dynamic subtest pipe-D: SKIP (0.031s) [289.452223] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.145s) [289.520122] [057/133] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [289.607532] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [289.612072] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [289.687909] [058/133] (738s left) kms_atomic_transition (modeset-transition) [289.753065] Starting subtest: modeset-transition [289.755132] Starting dynamic subtest: 1x-outputs [300.627977] Dynamic subtest 1x-outputs: SUCCESS (10.874s) [300.630338] Subtest modeset-transition: SUCCESS (10.876s) [301.469358] [059/133] (726s left) gem_exec_fence (syncobj-export) [301.881180] Starting subtest: syncobj-export [301.887046] Subtest syncobj-export: SUCCESS (0.005s) [303.514936] [060/133] (724s left) kms_properties (plane-properties-legacy) [303.585865] Starting subtest: plane-properties-legacy [303.588450] Starting dynamic subtest: pipe-A-eDP-1 [304.164030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s) [304.192856] Starting dynamic subtest: pipe-B-eDP-1 [305.468893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.301s) [305.480013] Starting dynamic subtest: pipe-C-eDP-1 [306.705504] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s) [306.716490] Starting dynamic subtest: pipe-D-eDP-1 [307.936612] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s) [307.938487] Subtest plane-properties-legacy: SUCCESS (4.351s) [308.714846] [061/133] (719s left) kms_universal_plane (disable-primary-vs-flip) [308.779626] Starting subtest: disable-primary-vs-flip [308.781934] Starting dynamic subtest: pipe-A-eDP-1 [310.304662] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.523s) [310.315756] Starting dynamic subtest: pipe-B-eDP-1 [312.490948] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.183s) [312.502615] Starting dynamic subtest: pipe-C-eDP-1 [314.735490] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.244s) [314.748319] Starting dynamic subtest: pipe-D-eDP-1 [316.918757] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.183s) [316.921414] Subtest disable-primary-vs-flip: SUCCESS (8.139s) [317.699346] [062/133] (710s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [317.777733] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [317.779915] Starting dynamic subtest: pipe-A-default-mode [318.971894] Dynamic subtest pipe-A-default-mode: SKIP (1.191s) [318.976134] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.192s) [319.072519] [063/133] (708s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [319.185010] Starting subtest: cursorA-vs-flipB-atomic [319.189573] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [319.319976] [064/133] (708s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [319.403404] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [319.407803] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [319.475511] [065/133] (708s left) kms_plane_scaling (planes-scaler-unity-scaling) [319.545474] Starting subtest: planes-scaler-unity-scaling [319.547803] Starting dynamic subtest: pipe-A [319.607325] Dynamic subtest pipe-A: SUCCESS (0.064s) [319.619351] Starting dynamic subtest: pipe-B [320.772905] Dynamic subtest pipe-B: SUCCESS (1.164s) [320.785248] Starting dynamic subtest: pipe-C [321.893739] Dynamic subtest pipe-C: SUCCESS (1.119s) [321.910465] Starting dynamic subtest: pipe-D [323.007393] Dynamic subtest pipe-D: SUCCESS (1.113s) [323.009791] Subtest planes-scaler-unity-scaling: SUCCESS (3.464s) [324.166562] [066/133] (703s left) kms_atomic_transition (plane-all-transition) [324.241702] Starting subtest: plane-all-transition [324.243949] Starting dynamic subtest: pipe-A-eDP-1 [326.738084] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s) [327.055287] Starting dynamic subtest: pipe-B-eDP-1 [330.318328] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.272s) [330.615048] Subtest plane-all-transition: SUCCESS (6.373s) [331.424132] [067/133] (696s left) gem_eio (wait-10ms) [331.644461] Starting subtest: wait-10ms [331.955403] Subtest wait-10ms: SUCCESS (0.310s) [332.056891] [068/133] (696s left) gem_mmap_offset (bad-extensions) [332.109294] Starting subtest: bad-extensions [332.111603] Subtest bad-extensions: SUCCESS (0.000s) [332.196866] [069/133] (696s left) i915_hangman (gt-error-state-capture) [332.263214] Starting subtest: gt-error-state-capture [332.265542] Starting dynamic subtest: rcs0 [343.423754] Dynamic subtest rcs0: SUCCESS (11.160s) [343.437974] Starting dynamic subtest: bcs0 [355.457217] Dynamic subtest bcs0: SUCCESS (12.030s) [355.470165] Starting dynamic subtest: vcs0 [367.489472] Dynamic subtest vcs0: SUCCESS (12.029s) [367.501374] Starting dynamic subtest: vcs1 [381.490580] Dynamic subtest vcs1: SUCCESS (13.946s) [381.503425] Starting dynamic subtest: vecs0 [391.423719] Dynamic subtest vecs0: SUCCESS (9.981s) [391.437688] Starting dynamic subtest: ccs0 [403.456086] Dynamic subtest ccs0: SUCCESS (12.029s) [403.459310] Subtest gt-error-state-capture: SUCCESS (71.191s) [403.558665] [070/133] (624s left) kms_psr (psr-sprite-mmap-cpu) [403.644542] Starting subtest: psr-sprite-mmap-cpu [403.646770] Starting dynamic subtest: eDP-1 [405.347344] Dynamic subtest eDP-1: SUCCESS (1.701s) [405.349513] Subtest psr-sprite-mmap-cpu: SUCCESS (1.702s) [406.166192] [071/133] (622s left) kms_rotation_crc (primary-rotation-180) [406.233613] Starting subtest: primary-rotation-180 [413.169832] Subtest primary-rotation-180: SUCCESS (6.937s) [414.336640] [072/133] (614s left) kms_hdr (brightness-with-hdr) [414.407502] Starting subtest: brightness-with-hdr [414.413926] Subtest brightness-with-hdr: SKIP (0.000s) [414.456560] [073/133] (613s left) kms_async_flips (async-flip-hang) [414.536809] Starting subtest: async-flip-hang [414.911898] Starting dynamic subtest: pipe-A-eDP-1 [430.015449] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.101s) [430.387696] Starting dynamic subtest: pipe-B-eDP-1 [446.012362] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.629s) [446.388745] Starting dynamic subtest: pipe-C-eDP-1 [461.956814] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.562s) [462.326451] Starting dynamic subtest: pipe-D-eDP-1 [477.945528] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.628s) [477.947903] Subtest async-flip-hang: SUCCESS (63.406s) [479.116271] [074/133] (549s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [479.197450] Starting subtest: fbc-rgb565-draw-blt [483.364699] Subtest fbc-rgb565-draw-blt: SUCCESS (4.171s) [484.510633] [075/133] (543s left) syncobj_basic (illegal-fd-to-handle) [484.554477] Starting subtest: illegal-fd-to-handle [484.556325] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [484.628630] [076/133] (543s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [484.739895] Starting subtest: 2x-flip-vs-cursor-atomic [484.744178] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [484.859829] [077/133] (543s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [484.924428] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [484.928423] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [484.992199] [078/133] (543s left) gem_exercise_blt (fast-copy) [485.045896] Starting subtest: fast-copy [485.048123] Starting dynamic subtest: linear-smem-smem [485.069798] Dynamic subtest linear-smem-smem: SUCCESS (0.024s) [485.080124] Starting dynamic subtest: xmajor-smem-smem [485.088741] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s) [485.098677] Starting dynamic subtest: tile4-smem-smem [485.107011] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s) [485.117130] Starting dynamic subtest: tile64-smem-smem [485.126048] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s) [485.128259] Subtest fast-copy: SUCCESS (0.081s) [485.205184] [079/133] (543s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [485.285687] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [485.287636] Starting dynamic subtest: pipe-A-eDP-1 [487.405926] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.122s) [487.416499] Starting dynamic subtest: pipe-B-eDP-1 [489.603892] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.196s) [489.614281] Starting dynamic subtest: pipe-C-eDP-1 [491.647084] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.041s) [491.657970] Starting dynamic subtest: pipe-D-eDP-1 [493.725443] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.078s) [493.727664] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.442s) [494.914892] [080/133] (533s left) perf (gen12-invalid-class-instance) [494.987813] Starting subtest: gen12-invalid-class-instance [494.998068] Subtest gen12-invalid-class-instance: SUCCESS (0.008s) [495.047978] [081/133] (533s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [495.122494] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [495.131946] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.008s) [495.184007] [082/133] (533s left) syncobj_wait (multi-wait-all-submitted-signaled) [495.245595] Starting subtest: multi-wait-all-submitted-signaled [495.350974] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s) [495.408468] [083/133] (533s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [495.485194] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [495.494297] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.008s) [495.552047] [084/133] (533s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [495.620734] Starting subtest: fbcpsr-rgb565-draw-blt [502.533255] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.915s) [502.637695] [085/133] (526s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [502.723500] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [502.725793] Starting dynamic subtest: pipe-A-eDP-1 [503.269419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.519s) [503.280754] Starting dynamic subtest: pipe-B-eDP-1 [504.667893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s) [504.678923] Starting dynamic subtest: pipe-C-eDP-1 [506.037543] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s) [506.060578] Starting dynamic subtest: pipe-D-eDP-1 [507.351799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s) [507.354165] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.603s) [508.447134] [086/133] (520s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [508.523199] Starting subtest: psr-indfb-scaledprimary [514.288100] Subtest psr-indfb-scaledprimary: SUCCESS (5.769s) [514.380733] [087/133] (514s left) kms_concurrent (multi-plane-atomic-lowres) [514.462121] Starting subtest: multi-plane-atomic-lowres [514.464377] Starting dynamic subtest: pipe-A-eDP-1 [514.956703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s) [514.967958] Starting dynamic subtest: pipe-B-eDP-1 [516.233507] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.278s) [516.246110] Starting dynamic subtest: pipe-C-eDP-1 [517.455217] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.220s) [517.466441] Starting dynamic subtest: pipe-D-eDP-1 [518.706916] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s) [518.709254] Subtest multi-plane-atomic-lowres: SUCCESS (4.243s) [519.510713] [088/133] (509s left) api_intel_allocator (reopen-fork) [519.565319] Starting subtest: reopen-fork [522.925741] Subtest reopen-fork: SUCCESS (3.362s) [522.990264] [089/133] (506s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [523.044337] Starting subtest: multi-wait-for-submit-available-submitted-signaled [523.046786] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [523.118081] [090/133] (506s left) syncobj_wait (reset-unsignaled) [523.176056] Starting subtest: reset-unsignaled [523.178526] Subtest reset-unsignaled: SUCCESS (0.000s) [523.260847] [091/133] (505s left) device_reset (cold-reset-bound) [523.312469] Starting subtest: cold-reset-bound [523.316961] Subtest cold-reset-bound: SKIP (0.000s) [523.364859] [092/133] (505s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [523.465133] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [540.619108] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.154s) [541.395125] [093/133] (487s left) gem_ctx_sseu (engines) [541.461526] Subtest engines: SKIP (0.000s) [541.541682] [094/133] (487s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [541.614181] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [541.618317] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [541.671522] [095/133] (487s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [541.746709] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [541.751027] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [541.809211] [096/133] (487s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [541.903267] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [542.705481] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.803s) [542.880846] [097/133] (486s left) kms_lease (multimaster-lease) [542.970020] Starting subtest: multimaster-lease [542.972427] Subtest multimaster-lease: SUCCESS (0.003s) [543.051193] [098/133] (486s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [543.127353] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [543.131511] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [543.214200] [099/133] (486s left) kms_chamelium_frames (hdmi-crc-fast) [543.589585] Subtest hdmi-crc-fast: SKIP (0.000s) [544.426313] [100/133] (485s left) gem_lmem_swapping (verify) [544.474202] Subtest verify: SKIP (0.000s) [544.517686] [101/133] (485s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [544.588699] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [544.591233] Starting dynamic subtest: pipe-A-eDP-1 [550.415279] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.831s) [550.427349] Starting dynamic subtest: pipe-B-eDP-1 [557.077943] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.661s) [557.080217] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.494s) [557.935051] [102/133] (471s left) gem_exec_big (single) [557.984683] Starting subtest: single [559.113664] Subtest single: SUCCESS (1.127s) [559.236392] [103/133] (470s left) kms_cursor_crc (cursor-random-512x512) [559.546385] Starting subtest: cursor-random-512x512 [559.550595] Subtest cursor-random-512x512: SKIP (0.001s) [559.670505] [104/133] (470s left) kms_big_fb (x-tiled-64bpp-rotate-0) [559.760630] Starting subtest: x-tiled-64bpp-rotate-0 [561.241242] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.478s) [561.418199] [105/133] (468s left) perf (non-system-wide-paranoid) [561.508252] Starting subtest: non-system-wide-paranoid [561.534195] Subtest non-system-wide-paranoid: SUCCESS (0.026s) [561.586101] [106/133] (468s left) kms_psr (psr2-primary-mmap-gtt) [561.660530] Starting subtest: psr2-primary-mmap-gtt [561.663164] Starting dynamic subtest: eDP-1 [563.043406] Dynamic subtest eDP-1: SKIP (1.380s) [563.048231] Subtest psr2-primary-mmap-gtt: SKIP (1.382s) [563.153963] [107/133] (466s left) kms_hdmi_inject (inject-audio) [563.208281] Subtest inject-audio: SKIP (0.000s) [563.276468] [108/133] (466s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [563.353075] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [563.357262] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [563.434827] [109/133] (466s left) kms_addfb_basic (bad-pitch-0) [563.492487] Starting subtest: bad-pitch-0 [563.494321] Subtest bad-pitch-0: SUCCESS (0.000s) [563.585133] [110/133] (466s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [563.649499] Starting subtest: y-tiled-ccs-to-yf-tiled [563.653374] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [563.807714] [111/133] (466s left) kms_dp_link_training (uhbr-mst) [563.883451] Starting subtest: uhbr-mst [563.892225] Subtest uhbr-mst: SKIP (0.000s) [563.938615] [112/133] (466s left) kms_pm_rpm (dpms-non-lpsp) [565.644360] Starting subtest: dpms-non-lpsp [565.648973] Subtest dpms-non-lpsp: SKIP (0.001s) [566.205144] [113/133] (463s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [566.260629] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [566.317402] [114/133] (463s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [566.403012] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [566.407259] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [566.476572] [115/133] (463s left) gem_exec_reloc (basic-wc-cpu-active) [566.549115] Subtest basic-wc-cpu-active: SKIP (0.000s) [566.619555] [116/133] (463s left) kms_flip (2x-flip-vs-expired-vblank) [566.701288] Starting subtest: 2x-flip-vs-expired-vblank [566.708433] Subtest 2x-flip-vs-expired-vblank: SKIP (0.007s) [566.788241] [117/133] (463s left) gem_exec_reloc (basic-gtt-read) [566.845930] Subtest basic-gtt-read: SKIP (0.000s) [566.920533] [118/133] (463s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render) [567.001292] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render [567.005538] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [567.077539] [119/133] (463s left) gem_eio (in-flight-contexts-10ms) [567.303112] Starting subtest: in-flight-contexts-10ms [580.531437] Subtest in-flight-contexts-10ms: SUCCESS (13.227s) [580.652990] [120/133] (449s left) gen7_exec_parse (basic-rejected) [580.710030] Subtest basic-rejected: SKIP (0.000s) [580.783024] [121/133] (449s left) sysfs_preempt_timeout (idempotent) [580.845427] Starting subtest: idempotent [580.847750] Starting dynamic subtest: vecs0 [580.849941] Dynamic subtest vecs0: SUCCESS (0.001s) [580.861257] Starting dynamic subtest: ccs0 [580.863373] Dynamic subtest ccs0: SUCCESS (0.001s) [580.873714] Starting dynamic subtest: vcs0 [580.875554] Dynamic subtest vcs0: SUCCESS (0.001s) [580.885697] Starting dynamic subtest: bcs0 [580.887527] Dynamic subtest bcs0: SUCCESS (0.001s) [580.897446] Starting dynamic subtest: rcs0 [580.899607] Dynamic subtest rcs0: SUCCESS (0.001s) [580.909558] Starting dynamic subtest: vcs1 [580.911374] Dynamic subtest vcs1: SUCCESS (0.001s) [580.913228] Subtest idempotent: SUCCESS (0.012s) [580.950887] [122/133] (449s left) kms_cursor_crc (cursor-offscreen-512x170) [581.287543] Starting subtest: cursor-offscreen-512x170 [581.291756] Subtest cursor-offscreen-512x170: SKIP (0.001s) [581.407989] [123/133] (449s left) gem_workarounds (suspend-resume-fd) [581.491565] Starting subtest: suspend-resume-fd [597.640478] Subtest suspend-resume-fd: SUCCESS (2.001s) [597.750254] [124/133] (432s left) gem_pread (display) [597.815995] Subtest display: SKIP (0.000s) [597.881248] [125/133] (432s left) gem_exec_reloc (basic-gtt-wc-active) [597.947403] Subtest basic-gtt-wc-active: SKIP (0.000s) [598.028163] [126/133] (432s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [598.116394] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [604.867101] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.745s) [604.957829] [127/133] (425s left) sw_sync (alloc_timeline) [604.995251] Starting subtest: alloc_timeline [604.997164] Subtest alloc_timeline: SUCCESS (0.000s) [605.037554] [128/133] (425s left) kms_psr (pr-sprite-mmap-gtt) [605.103617] Starting subtest: pr-sprite-mmap-gtt [605.107978] Subtest pr-sprite-mmap-gtt: SKIP (0.000s) [605.155116] [129/133] (425s left) kms_pipe_crc_basic (hang-read-crc) [605.225397] Starting subtest: hang-read-crc [605.227710] Starting dynamic subtest: pipe-A-eDP-1 [607.264439] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.038s) [607.275562] Starting dynamic subtest: pipe-B-eDP-1 [609.943215] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.673s) [609.955902] Starting dynamic subtest: pipe-C-eDP-1 [612.549323] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.604s) [612.561444] Starting dynamic subtest: pipe-D-eDP-1 [615.203212] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.651s) [615.205495] Subtest hang-read-crc: SUCCESS (9.971s) [616.039188] [130/133] (414s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [616.112770] Starting subtest: fbc-rgb101010-draw-mmap-cpu [620.651722] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.543s) [621.751265] [131/133] (409s left) syncobj_wait (multi-wait-all-for-submit-submitted) [621.805471] Starting subtest: multi-wait-all-for-submit-submitted [621.909048] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s) [621.962231] [132/133] (408s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [622.040346] Starting subtest: psr-1p-pri-indfb-multidraw [644.248139] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.203s) [644.343028] [133/133] (386s left) gem_ctx_persistence (engines-hostile) [644.400380] Starting subtest: engines-hostile [644.402252] Starting dynamic subtest: rcs0 [644.514958] Dynamic subtest rcs0: SUCCESS (0.114s) [644.528454] Starting dynamic subtest: bcs0 [644.620217] Dynamic subtest bcs0: SUCCESS (0.103s) [644.632963] Starting dynamic subtest: vcs0 [644.716145] Dynamic subtest vcs0: SUCCESS (0.094s) [644.729221] Starting dynamic subtest: vcs1 [644.813377] Dynamic subtest vcs1: SUCCESS (0.095s) [644.827400] Starting dynamic subtest: vecs0 [644.918525] Dynamic subtest vecs0: SUCCESS (0.103s) [644.932156] Starting dynamic subtest: ccs0 [644.987031] Dynamic subtest ccs0: SUCCESS (0.067s) [644.989204] Subtest engines-hostile: SUCCESS (0.588s) [645.095637] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: gem_mmap_wc results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: perf_pmu results: parsing output: 6/ for test: syncobj_eventfd results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: gem_exec_params results: parsing output: 9/ for test: kms_getfb results: parsing output: 10/ for test: kms_chamelium_color results: parsing output: 11/ for test: gem_userptr_blits results: parsing output: 12/ for test: kms_psr2_sf results: parsing output: 13/ for test: gem_spin_batch results: parsing output: 14/ for test: gem_exec_schedule results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: gem_partial_pwrite_pread results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: kms_ccs results: parsing output: 19/ for test: kms_plane results: parsing output: 20/ for test: kms_color_pipeline results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: gem_exec_schedule results: parsing output: 23/ for test: i915_drm_fdinfo results: parsing output: 24/ for test: gem_exec_schedule results: parsing output: 25/ for test: gem_close_race results: parsing output: 26/ for test: gem_exec_suspend results: parsing output: 27/ for test: kms_joiner results: parsing output: 28/ for test: fbdev results: parsing output: 29/ for test: kms_pm_rpm results: parsing output: 30/ for test: gem_pxp results: parsing output: 31/ for test: kms_psr2_sf results: parsing output: 32/ for test: i915_pm_rps results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: i915_query results: parsing output: 35/ for test: gem_exec_balancer results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: kms_draw_crc results: parsing output: 39/ for test: i915_suspend results: parsing output: 40/ for test: kms_flip results: parsing output: 41/ for test: perf results: parsing output: 42/ for test: api_intel_bb results: parsing output: 43/ for test: gem_render_copy results: parsing output: 44/ for test: gem_eio results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_vrr results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: kms_chamelium_hpd results: parsing output: 51/ for test: perf_pmu results: parsing output: 52/ for test: gem_ctx_persistence results: parsing output: 53/ for test: prime_vgem results: parsing output: 54/ for test: perf_pmu results: parsing output: 55/ for test: kms_plane_scaling results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_atomic_transition results: parsing output: 58/ for test: gem_exec_fence results: parsing output: 59/ for test: kms_properties results: parsing output: 60/ for test: kms_universal_plane results: parsing output: 61/ for test: kms_flip_scaled_crc results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_plane_scaling results: parsing output: 65/ for test: kms_atomic_transition results: parsing output: 66/ for test: gem_eio results: parsing output: 67/ for test: gem_mmap_offset results: parsing output: 68/ for test: i915_hangman results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: kms_rotation_crc results: parsing output: 71/ for test: kms_hdr results: parsing output: 72/ for test: kms_async_flips results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: syncobj_basic results: parsing output: 75/ for test: kms_cursor_legacy results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_exercise_blt results: parsing output: 78/ for test: kms_ccs results: parsing output: 79/ for test: perf results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: syncobj_wait results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_concurrent results: parsing output: 87/ for test: api_intel_allocator results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: device_reset results: parsing output: 91/ for test: kms_cursor_legacy results: parsing output: 92/ for test: gem_ctx_sseu results: parsing output: 93/ for test: kms_plane results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: kms_lease results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_chamelium_frames results: parsing output: 99/ for test: gem_lmem_swapping results: parsing output: 100/ for test: kms_psr2_sf results: parsing output: 101/ for test: gem_exec_big results: parsing output: 102/ for test: kms_cursor_crc results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: perf results: parsing output: 105/ for test: kms_psr results: parsing output: 106/ for test: kms_hdmi_inject results: parsing output: 107/ for test: kms_big_fb results: parsing output: 108/ for test: kms_addfb_basic results: parsing output: 109/ for test: gem_render_copy results: parsing output: 110/ for test: kms_dp_link_training results: parsing output: 111/ for test: kms_pm_rpm results: parsing output: 112/ for test: kms_pipe_b_c_ivb results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_flip results: parsing output: 116/ for test: gem_exec_reloc results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_eio results: parsing output: 119/ for test: gen7_exec_parse results: parsing output: 120/ for test: sysfs_preempt_timeout results: parsing output: 121/ for test: kms_cursor_crc results: parsing output: 122/ for test: gem_workarounds results: parsing output: 123/ for test: gem_pread results: parsing output: 124/ for test: gem_exec_reloc results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: sw_sync results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_pipe_crc_basic results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: syncobj_wait results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_ctx_persistence Done.