[57.296119] Initializing watchdogs [57.296167] /dev/watchdog0 [57.311839] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.316422] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.318762] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.322202] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [57.459110] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [64.106092] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.623s) [64.217660] [002/132] (953s left) kms_pwrite_crc [65.902036] [003/132] (952s left) kms_vblank (ts-continuation-modeset) [65.999269] Starting subtest: ts-continuation-modeset [66.001453] Starting dynamic subtest: pipe-A-eDP-1 [67.457238] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.451s) [67.472802] Starting dynamic subtest: pipe-D-eDP-1 [69.637092] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.175s) [69.639027] Subtest ts-continuation-modeset: SUCCESS (3.629s) [70.426391] [004/132] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [70.520576] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [75.199815] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.680s) [76.338990] [005/132] (941s left) perf_pmu (busy-idle-no-semaphores) [76.386905] Starting subtest: busy-idle-no-semaphores [76.389483] Starting dynamic subtest: rcs0 [77.043737] Dynamic subtest rcs0: SUCCESS (0.654s) [77.052967] Starting dynamic subtest: bcs0 [77.694416] Dynamic subtest bcs0: SUCCESS (0.648s) [77.704887] Starting dynamic subtest: vcs0 [78.344080] Dynamic subtest vcs0: SUCCESS (0.649s) [78.355170] Starting dynamic subtest: vcs1 [79.948386] Dynamic subtest vcs1: SUCCESS (1.602s) [79.957871] Starting dynamic subtest: vecs0 [81.929710] Dynamic subtest vecs0: SUCCESS (1.980s) [81.939724] Starting dynamic subtest: ccs0 [83.979734] Dynamic subtest ccs0: SUCCESS (2.049s) [83.982692] Subtest busy-idle-no-semaphores: SUCCESS (7.589s) [84.095962] [006/132] (933s left) syncobj_timeline (32bits-limit) [84.153750] Starting subtest: 32bits-limit [84.156094] Subtest 32bits-limit: SUCCESS (0.001s) [84.247422] [007/132] (933s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [84.340440] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [84.352590] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s) [84.452276] [008/132] (933s left) i915_power (sanity) [84.498558] Starting subtest: sanity [84.502607] Subtest sanity: SKIP (0.000s) [84.601184] [009/132] (933s left) kms_dsc (dsc-with-bpc) [84.688289] Starting subtest: dsc-with-bpc [84.719844] Subtest dsc-with-bpc: SKIP (0.001s) [84.774889] [010/132] (933s left) i915_query (query-topology-known-pci-ids) [84.830722] Starting subtest: query-topology-known-pci-ids [84.835208] Subtest query-topology-known-pci-ids: SKIP (0.000s) [84.930460] [011/132] (933s left) gem_partial_pwrite_pread (writes-after-reads-display) [84.984969] Subtest writes-after-reads-display: SKIP (0.000s) [85.050540] [012/132] (933s left) perf (mi-rpc) [85.162284] Starting subtest: mi-rpc [85.165851] Subtest mi-rpc: SKIP (0.000s) [85.201933] [013/132] (933s left) gem_exec_fence (invalid-timeline-fence-array) [85.744027] Starting subtest: invalid-timeline-fence-array [85.748929] Subtest invalid-timeline-fence-array: SUCCESS (0.005s) [87.415804] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [87.418848] [014/132] (930s left) kms_addfb_basic (framebuffer-vs-set-tiling) [87.478797] Starting subtest: framebuffer-vs-set-tiling [87.483101] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [87.624990] [015/132] (930s left) syncobj_timeline (invalid-wait-illegal-handle) [87.679735] Starting subtest: invalid-wait-illegal-handle [87.681634] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [87.777480] [016/132] (930s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [87.832892] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [87.941626] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [88.045433] [017/132] (930s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [88.163652] Starting subtest: modeset-atomic-cursor-hotspot [88.168188] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [88.311212] [018/132] (930s left) api_intel_bb (add-remove-objects) [88.372688] Starting subtest: add-remove-objects [88.377804] Subtest add-remove-objects: SUCCESS (0.007s) [88.505655] [019/132] (930s left) kms_getfb (getfb-handle-closed) [88.603811] Starting subtest: getfb-handle-closed [88.606218] Subtest getfb-handle-closed: SUCCESS (0.000s) [88.704863] [020/132] (929s left) syncobj_timeline (etime-single-wait-all-submitted) [88.765861] Starting subtest: etime-single-wait-all-submitted [88.871025] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s) [88.962424] [021/132] (929s left) kms_atomic_transition (modeset-transition) [89.051351] Starting subtest: modeset-transition [89.053582] Starting dynamic subtest: 1x-outputs [100.067774] Dynamic subtest 1x-outputs: SUCCESS (11.017s) [100.070274] Subtest modeset-transition: SUCCESS (11.018s) [100.928095] [022/132] (917s left) i915_module_load (reload) [100.969911] Starting subtest: reload [104.156829] Subtest reload: SUCCESS (3.187s) [104.199949] [023/132] (914s left) kms_psr2_sf (pr-cursor-plane-update-sf) [105.330106] Starting subtest: pr-cursor-plane-update-sf [105.334598] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [105.395233] [024/132] (913s left) kms_busy (basic) [105.508373] Starting subtest: basic [105.510804] Starting dynamic subtest: flip [106.125999] Dynamic subtest flip: SUCCESS (0.620s) [106.135318] Starting dynamic subtest: modeset [109.541543] Dynamic subtest modeset: SUCCESS (3.413s) [109.543931] Subtest basic: SUCCESS (4.033s) [110.352331] [025/132] (908s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [110.459989] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [110.464490] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [110.558306] [026/132] (908s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [110.665873] Starting subtest: yf-tiled-64bpp-rotate-270 [110.670490] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [110.765282] [027/132] (908s left) vgem_basic (bad-fence) [110.815680] Starting subtest: bad-fence [110.817988] Subtest bad-fence: SUCCESS (0.000s) [110.874413] [028/132] (908s left) gem_exec_schedule (preempt-engines) [110.944555] Starting subtest: preempt-engines [110.946656] Starting dynamic subtest: rcs0 [113.261571] Dynamic subtest rcs0: SUCCESS (2.325s) [113.270200] Starting dynamic subtest: bcs0 [115.568309] Dynamic subtest bcs0: SUCCESS (2.305s) [115.580358] Starting dynamic subtest: vcs0 [117.842520] Dynamic subtest vcs0: SUCCESS (2.273s) [117.854204] Starting dynamic subtest: vcs1 [120.133330] Dynamic subtest vcs1: SUCCESS (2.290s) [120.144962] Starting dynamic subtest: vecs0 [122.407969] Dynamic subtest vecs0: SUCCESS (2.274s) [122.419185] Starting dynamic subtest: ccs0 [124.718513] Dynamic subtest ccs0: SUCCESS (2.309s) [124.720882] Subtest preempt-engines: SUCCESS (13.783s) [125.019575] [029/132] (893s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [125.113800] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [125.116073] Starting dynamic subtest: pipe-A-eDP-1 [125.141044] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [125.151484] Starting dynamic subtest: pipe-B-eDP-1 [125.174742] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [125.183256] Starting dynamic subtest: pipe-C-eDP-1 [125.207074] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [125.216048] Starting dynamic subtest: pipe-D-eDP-1 [125.239702] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [125.244059] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [127.394817] [030/132] (891s left) kms_flip (flip-vs-suspend-interruptible) [127.492426] Starting subtest: flip-vs-suspend-interruptible [127.494756] Starting dynamic subtest: A-eDP1 [242.125837] Dynamic subtest A-eDP1: SUCCESS (12.047s) [242.128309] Subtest flip-vs-suspend-interruptible: SUCCESS (12.049s) [252.283431] [031/132] (776s left) gem_exec_reloc (basic-write-wc-noreloc) [252.367248] Subtest basic-write-wc-noreloc: SKIP (0.000s) [252.441679] [032/132] (776s left) kms_color (invalid-gamma-lut-sizes) [252.533961] Starting subtest: invalid-gamma-lut-sizes [252.536324] Starting dynamic subtest: pipe-A [252.835100] Dynamic subtest pipe-A: SUCCESS (0.299s) [252.844938] Starting dynamic subtest: pipe-B [252.847259] Dynamic subtest pipe-B: SUCCESS (0.000s) [252.856199] Starting dynamic subtest: pipe-C [252.858674] Dynamic subtest pipe-C: SUCCESS (0.000s) [252.867890] Starting dynamic subtest: pipe-D [252.870148] Dynamic subtest pipe-D: SUCCESS (0.000s) [252.872387] Subtest invalid-gamma-lut-sizes: SUCCESS (0.302s) [253.712378] [033/132] (775s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [253.813305] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [253.817701] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [253.882949] [034/132] (775s left) gem_exec_nop (basic-parallel) [253.951556] Starting subtest: basic-parallel [269.848419] Subtest basic-parallel: SUCCESS (15.840s) [270.089245] [035/132] (759s left) gem_render_copy_redux (flink) [270.151729] Starting subtest: flink [271.333975] Subtest flink: SUCCESS (1.183s) [271.460713] [036/132] (757s left) perf_pmu (busy-check-all) [271.506610] Starting subtest: busy-check-all [271.508374] Starting dynamic subtest: rcs0 [272.076710] Dynamic subtest rcs0: SUCCESS (0.569s) [272.088897] Starting dynamic subtest: bcs0 [272.630373] Dynamic subtest bcs0: SUCCESS (0.551s) [272.643052] Starting dynamic subtest: vcs0 [273.943259] Dynamic subtest vcs0: SUCCESS (1.307s) [273.955271] Starting dynamic subtest: vcs1 [275.926462] Dynamic subtest vcs1: SUCCESS (1.980s) [275.938734] Starting dynamic subtest: vecs0 [277.910849] Dynamic subtest vecs0: SUCCESS (1.980s) [277.922126] Starting dynamic subtest: ccs0 [278.466202] Dynamic subtest ccs0: SUCCESS (0.555s) [278.468556] Subtest busy-check-all: SUCCESS (6.953s) [278.561826] [037/132] (750s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [278.655364] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [278.657647] Starting dynamic subtest: pipe-A-eDP-1 [278.714543] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [278.723594] Starting dynamic subtest: pipe-B-eDP-1 [278.780583] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [278.790909] Starting dynamic subtest: pipe-C-eDP-1 [278.848758] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [278.858845] Starting dynamic subtest: pipe-D-eDP-1 [278.915056] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [278.919330] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s) [280.961940] [038/132] (748s left) gem_exec_reloc (basic-cpu-noreloc) [281.039001] Subtest basic-cpu-noreloc: SKIP (0.000s) [281.110339] [039/132] (748s left) kms_cursor_crc (cursor-alpha-opaque) [281.203995] Starting subtest: cursor-alpha-opaque [281.205892] Starting dynamic subtest: pipe-A-eDP-1 [281.818521] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.614s) [281.827859] Starting dynamic subtest: pipe-D-eDP-1 [283.134746] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s) [283.137020] Subtest cursor-alpha-opaque: SUCCESS (1.931s) [283.942568] [040/132] (745s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier) [284.036745] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier [284.041113] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s) [284.113045] [041/132] (745s left) core_setmaster (master-drop-set-shared-fd) [284.215237] Starting subtest: master-drop-set-shared-fd [284.236892] Subtest master-drop-set-shared-fd: SUCCESS (0.022s) [284.276300] [042/132] (745s left) gem_userptr_blits (usage-restrictions) [284.332869] Starting subtest: usage-restrictions [284.334795] Subtest usage-restrictions: SUCCESS (0.000s) [284.456622] [043/132] (745s left) gem_mmap_gtt (basic-small-copy) [284.511014] Subtest basic-small-copy: SKIP (0.000s) [284.574182] [044/132] (745s left) gem_lmem_swapping (massive) [284.619544] Subtest massive: SKIP (0.000s) [284.669339] [045/132] (745s left) kms_flip (dpms-vs-vblank-race) [284.768857] Starting subtest: dpms-vs-vblank-race [284.770743] Starting dynamic subtest: A-eDP1 [289.723588] Dynamic subtest A-eDP1: SUCCESS (4.956s) [289.732822] Starting dynamic subtest: B-eDP1 [294.343405] Dynamic subtest B-eDP1: SUCCESS (4.614s) [294.353984] Starting dynamic subtest: C-eDP1 [298.958120] Dynamic subtest C-eDP1: SUCCESS (4.613s) [298.968288] Starting dynamic subtest: D-eDP1 [303.597593] Dynamic subtest D-eDP1: SUCCESS (4.635s) [303.599854] Subtest dpms-vs-vblank-race: SUCCESS (18.833s) [304.484603] [046/132] (725s left) syncobj_wait (invalid-reset-zero-handles) [304.557006] Starting subtest: invalid-reset-zero-handles [304.559610] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [304.665586] [047/132] (725s left) kms_big_fb (y-tiled-32bpp-rotate-270) [304.762963] Starting subtest: y-tiled-32bpp-rotate-270 [304.767432] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [304.865780] [048/132] (724s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [304.978306] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [304.982628] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [305.079992] [049/132] (724s left) kms_frontbuffer_tracking (psr-1p-rte) [305.184704] Starting subtest: psr-1p-rte [310.577882] Subtest psr-1p-rte: SUCCESS (5.398s) [310.728884] [050/132] (719s left) api_intel_bb (misplaced-blitter) [310.797799] Starting subtest: misplaced-blitter [310.802872] Subtest misplaced-blitter: SUCCESS (0.006s) [310.928835] [051/132] (719s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [311.032448] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [311.036815] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [311.130929] [052/132] (718s left) gem_eio (in-flight-external) [311.349486] Starting subtest: in-flight-external [312.988379] Subtest in-flight-external: SUCCESS (1.639s) [313.105272] [053/132] (716s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [313.204362] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [313.208746] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [313.289966] [054/132] (716s left) kms_pipe_crc_basic (suspend-read-crc) [313.394340] Starting subtest: suspend-read-crc [313.396229] Starting dynamic subtest: pipe-A-eDP-1 [331.020784] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.910s) [331.030738] Starting dynamic subtest: pipe-B-eDP-1 [350.063918] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.599s) [350.073641] Starting dynamic subtest: pipe-C-eDP-1 [368.989253] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.530s) [369.000641] Starting dynamic subtest: pipe-D-eDP-1 [388.000137] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.447s) [388.002496] Subtest suspend-read-crc: SUCCESS (13.495s) [395.846104] [055/132] (641s left) gem_ctx_sseu (invalid-sseu) [395.908754] Subtest invalid-sseu: SKIP (0.000s) [395.991684] [056/132] (641s left) kms_plane (planar-pixel-format-settings) [396.095686] Starting subtest: planar-pixel-format-settings [396.169467] Subtest planar-pixel-format-settings: SUCCESS (0.074s) [396.288715] [057/132] (640s left) kms_chamelium_frames (hdmi-crc-single) [396.683016] Subtest hdmi-crc-single: SKIP (0.000s) [397.459384] [058/132] (639s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [397.564638] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [404.322120] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.712s) [404.452632] [059/132] (632s left) kms_flip (flip-vs-dpms-off-vs-modeset) [404.538735] Starting subtest: flip-vs-dpms-off-vs-modeset [404.545937] Starting dynamic subtest: A-eDP1 [408.171442] Dynamic subtest A-eDP1: SUCCESS (3.613s) [408.181612] Starting dynamic subtest: B-eDP1 [411.489877] Dynamic subtest B-eDP1: SUCCESS (3.311s) [411.500776] Starting dynamic subtest: C-eDP1 [414.604380] Dynamic subtest C-eDP1: SUCCESS (3.110s) [414.614950] Starting dynamic subtest: D-eDP1 [417.721617] Dynamic subtest D-eDP1: SUCCESS (3.112s) [417.723902] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.156s) [418.526268] [060/132] (618s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [418.624321] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [418.626634] Starting dynamic subtest: pipe-A-eDP-1 [418.635641] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [418.645854] Starting dynamic subtest: pipe-B-eDP-1 [418.654921] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [418.665626] Starting dynamic subtest: pipe-C-eDP-1 [418.674237] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [418.683558] Starting dynamic subtest: pipe-D-eDP-1 [418.691679] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [418.695617] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.015s) [420.911723] [061/132] (616s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [421.013401] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [421.015613] Starting dynamic subtest: pipe-A-default-mode [423.777414] Dynamic subtest pipe-A-default-mode: SUCCESS (2.760s) [423.779675] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.762s) [424.627977] [062/132] (612s left) kms_cursor_edge_walk (256x256-top-edge) [424.718020] Starting subtest: 256x256-top-edge [424.720163] Starting dynamic subtest: pipe-A-eDP-1 [428.185832] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s) [428.196178] Starting dynamic subtest: pipe-D-eDP-1 [431.314790] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s) [431.317012] Subtest 256x256-top-edge: SUCCESS (6.596s) [432.121629] [063/132] (605s left) gem_close (many-handles-one-vma) [432.185136] Starting subtest: many-handles-one-vma [432.210436] Subtest many-handles-one-vma: SUCCESS (0.025s) [432.310525] [064/132] (605s left) i915_drm_fdinfo (memory-info-idle) [432.352394] Starting subtest: memory-info-idle [432.354681] Starting dynamic subtest: smem0 [432.392640] Dynamic subtest smem0: SUCCESS (0.040s) [432.395337] Subtest memory-info-idle: SUCCESS (0.041s) [432.483325] [065/132] (605s left) gem_exec_reloc (basic-concurrent16) [432.545336] Subtest basic-concurrent16: SKIP (0.000s) [432.616672] [066/132] (604s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [432.727550] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [432.731695] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [432.827380] [067/132] (604s left) gem_ctx_persistence (legacy-engines-queued) [432.892401] Starting subtest: legacy-engines-queued [432.894598] Starting dynamic subtest: render [432.967364] Dynamic subtest render: SUCCESS (0.077s) [432.979423] Starting dynamic subtest: bsd1 [434.987030] Dynamic subtest bsd1: SUCCESS (2.016s) [434.999499] Starting dynamic subtest: bsd2 [436.968877] Dynamic subtest bsd2: SUCCESS (1.978s) [436.982138] Starting dynamic subtest: blt [437.022222] Dynamic subtest blt: SUCCESS (0.052s) [437.033666] Starting dynamic subtest: vebox [439.018601] Dynamic subtest vebox: SUCCESS (1.993s) [439.021452] Subtest legacy-engines-queued: SUCCESS (6.129s) [439.097157] [068/132] (598s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [439.202437] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [439.585382] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [442.397976] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.810s) [442.411354] Starting dynamic subtest: pipe-A-eDP-1-4 [444.572943] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s) [444.584963] Starting dynamic subtest: pipe-A-eDP-1-4 [446.582437] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [446.595401] Starting dynamic subtest: pipe-A-eDP-1-x [448.773360] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s) [449.148214] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [451.922690] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.782s) [451.934222] Starting dynamic subtest: pipe-B-eDP-1-4 [454.109892] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [454.124530] Starting dynamic subtest: pipe-B-eDP-1-4 [456.119781] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [456.132719] Starting dynamic subtest: pipe-B-eDP-1-x [458.310641] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [458.676539] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [461.458082] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.788s) [461.469137] Starting dynamic subtest: pipe-C-eDP-1-4 [463.633038] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [463.643135] Starting dynamic subtest: pipe-C-eDP-1-4 [465.644007] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [465.656378] Starting dynamic subtest: pipe-C-eDP-1-x [467.834732] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s) [468.211130] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [470.992733] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.789s) [471.003689] Starting dynamic subtest: pipe-D-eDP-1-4 [473.168300] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s) [473.179762] Starting dynamic subtest: pipe-D-eDP-1-4 [475.179088] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [475.189153] Starting dynamic subtest: pipe-D-eDP-1-x [477.359188] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [477.361627] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.149s) [478.580151] [069/132] (559s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [478.676904] Starting subtest: fbcpsr-shrfb-scaledprimary [484.491159] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.815s) [484.627521] [070/132] (553s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [484.729273] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [484.731448] Starting dynamic subtest: pipe-A-eDP-1 [484.752677] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [484.766809] Starting dynamic subtest: pipe-B-eDP-1 [484.787794] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [484.797205] Starting dynamic subtest: pipe-C-eDP-1 [484.817793] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [484.827383] Starting dynamic subtest: pipe-D-eDP-1 [484.849103] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [484.853143] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [486.886132] [071/132] (550s left) gem_exec_store (basic) [486.957458] Starting subtest: basic [487.060607] Subtest basic: SUCCESS (0.102s) [487.250529] [072/132] (550s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [487.369486] Starting subtest: verify-pxp-key-change-after-suspend-resume [494.526384] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.157s) [501.648277] [073/132] (543s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [501.761978] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [502.553148] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.793s) [502.736428] [074/132] (542s left) prime_vgem (basic-gtt) [502.800822] Starting subtest: basic-gtt [502.805274] Subtest basic-gtt: SKIP (0.000s) [502.893766] [075/132] (542s left) kms_content_protection (atomic-dpms) [503.043382] Starting subtest: atomic-dpms [503.048438] Subtest atomic-dpms: SKIP (0.000s) [503.159066] [076/132] (541s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [503.222913] Starting subtest: y-tiled-ccs-to-y-tiled [503.227290] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [503.417035] [077/132] (541s left) gem_ppgtt (shrink-vs-evict-pinned) [503.473655] Starting subtest: shrink-vs-evict-pinned [510.049615] Subtest shrink-vs-evict-pinned: SUCCESS (6.578s) [510.131484] [078/132] (534s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping) [510.241627] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping [510.245826] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s) [510.322822] [079/132] (534s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [510.375861] Starting subtest: yf-tiled-to-vebox-y-tiled [510.380361] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [510.559489] [080/132] (534s left) kms_psr (fbc-psr2-cursor-render) [510.646964] Starting subtest: fbc-psr2-cursor-render [510.649390] Starting dynamic subtest: eDP-1 [510.653920] Dynamic subtest eDP-1: SKIP (0.000s) [510.658423] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [510.723893] [081/132] (534s left) vgem_slow (nohang) [510.772780] Starting subtest: nohang [521.065120] Subtest nohang: SUCCESS (10.294s) [521.134948] [082/132] (524s left) kms_psr (psr-sprite-blt) [521.229781] Starting subtest: psr-sprite-blt [521.232119] Starting dynamic subtest: eDP-1 [523.023522] Dynamic subtest eDP-1: SUCCESS (1.795s) [523.025859] Subtest psr-sprite-blt: SUCCESS (1.796s) [523.845495] [083/132] (521s left) syncobj_timeline (single-wait-all-available-signaled) [523.903491] Starting subtest: single-wait-all-available-signaled [523.905788] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [524.010672] [084/132] (521s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [524.121980] Starting subtest: short-flip-before-cursor-atomic-transitions [525.081611] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.957s) [525.876756] [085/132] (519s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [525.989876] Starting subtest: psr2-overlay-plane-update-continuous-sf [525.992098] Starting dynamic subtest: pipe-A-eDP-1 [527.142388] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.157s) [527.154233] Starting dynamic subtest: pipe-B-eDP-1 [528.940204] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.794s) [528.942499] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.954s) [529.753284] [086/132] (515s left) kms_addfb_basic (too-wide) [529.839482] Starting subtest: too-wide [529.841523] Subtest too-wide: SUCCESS (0.000s) [529.937037] [087/132] (515s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [530.046863] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [537.142794] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.100s) [537.250319] [088/132] (508s left) kms_lease (simple-lease) [537.355492] Starting subtest: simple-lease [537.357775] Starting dynamic subtest: pipe-A-eDP-1 [537.859231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.503s) [537.869500] Starting dynamic subtest: pipe-B-eDP-1 [539.323000] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.461s) [539.333182] Starting dynamic subtest: pipe-C-eDP-1 [540.728542] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s) [540.738869] Starting dynamic subtest: pipe-D-eDP-1 [542.124674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s) [542.127058] Subtest simple-lease: SUCCESS (4.771s) [542.937589] [089/132] (502s left) gem_exec_schedule (thriceslice) [543.011403] Starting subtest: thriceslice [543.013325] Starting dynamic subtest: rcs0 [543.031663] Dynamic subtest rcs0: SUCCESS (0.030s) [543.044175] Starting dynamic subtest: bcs0 [543.064677] Dynamic subtest bcs0: SUCCESS (0.031s) [543.074442] Starting dynamic subtest: vcs0 [543.094068] Dynamic subtest vcs0: SUCCESS (0.028s) [543.107634] Starting dynamic subtest: vcs1 [543.144472] Dynamic subtest vcs1: SUCCESS (0.049s) [543.157501] Starting dynamic subtest: vecs0 [543.173924] Dynamic subtest vecs0: SUCCESS (0.028s) [543.183743] Starting dynamic subtest: ccs0 [543.204064] Dynamic subtest ccs0: SUCCESS (0.029s) [543.206200] Subtest thriceslice: SUCCESS (0.203s) [543.507728] [090/132] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [543.602618] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [543.606503] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [543.735002] [091/132] (501s left) kms_invalid_mode (clock-too-high) [543.825181] Starting subtest: clock-too-high [543.827468] Starting dynamic subtest: pipe-A-eDP-1 [543.831808] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [543.841731] Starting dynamic subtest: pipe-B-eDP-1 [543.846046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [543.855555] Starting dynamic subtest: pipe-C-eDP-1 [543.859594] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [543.868746] Starting dynamic subtest: pipe-D-eDP-1 [543.872735] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [543.877045] Subtest clock-too-high: SKIP (0.004s) [543.916754] [092/132] (501s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [543.986506] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [544.055353] [093/132] (501s left) i915_pm_rc6_residency (rc6-fence) [544.108377] Starting subtest: rc6-fence [544.132243] Starting dynamic subtest: gt0 [556.448068] Dynamic subtest gt0: SUCCESS (12.316s) [556.461201] Starting dynamic subtest: gt1 [571.019902] Dynamic subtest gt1: SUCCESS (14.568s) [571.022341] Subtest rc6-fence: SUCCESS (26.914s) [571.099752] [094/132] (474s left) dumb_buffer (map-valid) [571.164004] Starting subtest: map-valid [571.166324] Subtest map-valid: SUCCESS (0.000s) [571.272697] [095/132] (474s left) kms_rotation_crc (primary-rotation-270) [571.374756] Starting subtest: primary-rotation-270 [571.379206] Subtest primary-rotation-270: SKIP (0.001s) [571.460787] [096/132] (474s left) kms_sequence (get-forked) [571.550917] Starting subtest: get-forked [571.553118] Starting dynamic subtest: pipe-A-eDP-1 [573.444122] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.893s) [573.454853] Starting dynamic subtest: pipe-B-eDP-1 [575.970188] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.525s) [575.984362] Starting dynamic subtest: pipe-C-eDP-1 [578.488339] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.516s) [578.500775] Starting dynamic subtest: pipe-D-eDP-1 [581.029053] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s) [581.031272] Subtest get-forked: SUCCESS (9.476s) [581.876137] [097/132] (464s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [581.997991] Starting subtest: 2x-long-cursor-vs-flip-atomic [582.002512] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [582.146206] [098/132] (463s left) gem_wait (wait) [582.204170] Starting subtest: wait [582.206545] Starting dynamic subtest: all-engines [584.011350] Dynamic subtest all-engines: SUCCESS (1.805s) [584.024160] Starting dynamic subtest: rcs0 [585.058029] Dynamic subtest rcs0: SUCCESS (1.044s) [585.071375] Starting dynamic subtest: bcs0 [586.105905] Dynamic subtest bcs0: SUCCESS (1.046s) [586.118978] Starting dynamic subtest: vcs0 [587.152923] Dynamic subtest vcs0: SUCCESS (1.045s) [587.169242] Starting dynamic subtest: vcs1 [588.200399] Dynamic subtest vcs1: SUCCESS (1.044s) [588.216839] Starting dynamic subtest: vecs0 [589.246147] Dynamic subtest vecs0: SUCCESS (1.043s) [589.259302] Starting dynamic subtest: ccs0 [590.293833] Dynamic subtest ccs0: SUCCESS (1.045s) [590.296254] Subtest wait: SUCCESS (8.090s) [590.495034] [099/132] (455s left) gem_partial_pwrite_pread (write-display) [590.544559] Subtest write-display: SKIP (0.000s) [590.614985] [100/132] (455s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [590.727152] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [597.664138] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.938s) [597.792943] [101/132] (448s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [597.886543] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [597.888840] Starting dynamic subtest: pipe-A-eDP-1 [597.911346] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [597.923273] Starting dynamic subtest: pipe-B-eDP-1 [597.944508] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [597.953997] Starting dynamic subtest: pipe-C-eDP-1 [597.974926] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [597.984185] Starting dynamic subtest: pipe-D-eDP-1 [598.004776] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [598.008677] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [600.172360] [102/132] (446s left) kms_draw_crc (fill-fb) [600.272740] Starting subtest: fill-fb [600.725236] Subtest fill-fb: SUCCESS (0.454s) [600.824650] [103/132] (445s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [600.932680] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [605.271481] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.342s) [606.478560] [104/132] (439s left) kms_pm_dc (dc9-dpms) [607.581360] Starting subtest: dc9-dpms [609.038362] Subtest dc9-dpms: SUCCESS (1.455s) [609.113321] [105/132] (437s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [609.195180] Starting subtest: primary-y-tiled-reflect-x-0 [609.257416] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s) [609.361668] [106/132] (436s left) kms_psr (fbc-psr-suspend) [609.447424] Starting subtest: fbc-psr-suspend [609.449670] Starting dynamic subtest: eDP-1 [609.453759] Dynamic subtest eDP-1: SKIP (0.000s) [609.457766] Subtest fbc-psr-suspend: SKIP (0.001s) [609.522202] [107/132] (436s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [609.620049] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [609.624152] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [609.708727] [108/132] (436s left) gem_exec_suspend (basic-s3) [609.767574] Starting subtest: basic-S3 [609.769871] Starting dynamic subtest: smem [629.589863] Dynamic subtest smem: SUCCESS (6.177s) [629.592834] Subtest basic-S3: SUCCESS (6.179s) [639.795596] [109/132] (416s left) syncobj_timeline (multi-wait-available-signaled) [639.855931] Starting subtest: multi-wait-available-signaled [639.858165] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [639.972171] [110/132] (416s left) gem_workarounds (reset) [640.037722] Starting subtest: reset [640.304331] Subtest reset: SUCCESS (0.265s) [640.442628] [111/132] (416s left) gem_softpin (allocator-nopin) [640.507319] Starting subtest: allocator-nopin [640.598023] Subtest allocator-nopin: SUCCESS (0.089s) [640.729897] [112/132] (415s left) perf (polling-small-buf) [640.842547] Starting subtest: polling-small-buf [640.937711] Subtest polling-small-buf: SUCCESS (0.093s) [640.988296] [113/132] (415s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [641.099384] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [648.511047] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.363s) [648.649255] [114/132] (408s left) gem_create (create-ext-cpu-access-big) [648.822312] Starting subtest: create-ext-cpu-access-big [648.827071] Subtest create-ext-cpu-access-big: SKIP (0.001s) [648.897442] [115/132] (407s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [649.001799] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [649.004126] Starting dynamic subtest: pipe-A [649.024151] Dynamic subtest pipe-A: SKIP (0.018s) [649.035385] Starting dynamic subtest: pipe-B [649.054943] Dynamic subtest pipe-B: SKIP (0.030s) [649.065773] Starting dynamic subtest: pipe-C [649.085609] Dynamic subtest pipe-C: SKIP (0.030s) [649.095900] Starting dynamic subtest: pipe-D [649.121700] Dynamic subtest pipe-D: SKIP (0.034s) [649.125543] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.116s) [649.219047] [116/132] (407s left) kms_psr (psr2-sprite-render) [649.306814] Starting subtest: psr2-sprite-render [649.309105] Starting dynamic subtest: eDP-1 [650.993851] Dynamic subtest eDP-1: SUCCESS (1.679s) [650.996124] Subtest psr2-sprite-render: SUCCESS (1.680s) [651.877186] [117/132] (404s left) gen9_exec_parse (basic-rejected-ctx-param) [651.936526] Subtest basic-rejected-ctx-param: SKIP (0.000s) [651.999330] [118/132] (404s left) vgem_basic (dmabuf-mmap) [652.038406] Starting subtest: dmabuf-mmap [652.085013] Subtest dmabuf-mmap: SUCCESS (0.048s) [652.140485] [119/132] (404s left) kms_psr (fbc-psr-basic) [652.250373] Starting subtest: fbc-psr-basic [652.252569] Starting dynamic subtest: eDP-1 [652.256533] Dynamic subtest eDP-1: SKIP (0.000s) [652.260468] Subtest fbc-psr-basic: SKIP (0.001s) [652.326530] [120/132] (404s left) kms_chamelium_hpd (hdmi-hpd-storm) [652.727020] Subtest hdmi-hpd-storm: SKIP (0.000s) [653.491758] [121/132] (403s left) syncobj_wait (wait-all-for-submit-snapshot) [653.539493] Starting subtest: wait-all-for-submit-snapshot [653.620137] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [653.702630] [122/132] (403s left) gem_mmap_offset (blt-coherency) [653.756220] Starting subtest: blt-coherency [653.761381] Subtest blt-coherency: SUCCESS (0.007s) [653.878047] [123/132] (403s left) kms_cursor_crc (cursor-random-64x21) [654.081282] Starting subtest: cursor-random-64x21 [654.130690] Subtest cursor-random-64x21: SKIP (0.043s) [654.390403] [124/132] (402s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [654.482000] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [655.152724] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s) [655.316180] [125/132] (401s left) gem_ctx_isolation (clean) [655.383620] Starting subtest: clean [655.386194] Starting dynamic subtest: rcs0 [655.410084] Dynamic subtest rcs0: SUCCESS (0.026s) [655.420614] Starting dynamic subtest: bcs0 [655.482567] Dynamic subtest bcs0: SUCCESS (0.072s) [655.492766] Starting dynamic subtest: vcs0 [655.552728] Dynamic subtest vcs0: SUCCESS (0.069s) [655.563270] Starting dynamic subtest: vcs1 [656.669687] Dynamic subtest vcs1: SUCCESS (1.114s) [656.679807] Starting dynamic subtest: vecs0 [658.669799] Dynamic subtest vecs0: SUCCESS (1.996s) [658.681111] Starting dynamic subtest: ccs0 [660.630085] Dynamic subtest ccs0: SUCCESS (1.956s) [660.632453] Subtest clean: SUCCESS (5.238s) [660.868790] [126/132] (396s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [660.963469] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [661.966149] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.002s) [662.100030] [127/132] (395s left) kms_properties (crtc-properties-legacy) [662.195093] Starting subtest: crtc-properties-legacy [662.197236] Starting dynamic subtest: pipe-A-eDP-1 [662.639757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s) [662.650743] Starting dynamic subtest: pipe-B-eDP-1 [663.799392] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s) [663.810227] Starting dynamic subtest: pipe-C-eDP-1 [664.927238] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s) [664.941352] Starting dynamic subtest: pipe-D-eDP-1 [666.064439] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s) [666.066344] Subtest crtc-properties-legacy: SUCCESS (3.865s) [666.888148] [128/132] (390s left) gem_exec_basic (basic) [666.945671] Starting subtest: basic [666.947907] Starting dynamic subtest: rcs0-smem [666.949835] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [666.961025] Starting dynamic subtest: bcs0-smem [666.963216] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [666.973112] Starting dynamic subtest: vcs0-smem [666.975275] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [666.984871] Starting dynamic subtest: vcs1-smem [666.987050] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [666.996699] Starting dynamic subtest: vecs0-smem [666.998833] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [667.010804] Starting dynamic subtest: ccs0-smem [667.013165] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [667.015381] Subtest basic: SUCCESS (0.017s) [668.682772] [129/132] (388s left) gem_exec_balancer (bonded-pair) [668.742949] Starting subtest: bonded-pair [668.747343] Subtest bonded-pair: SKIP (0.000s) [669.050509] [130/132] (388s left) kms_big_fb (x-tiled-64bpp-rotate-180) [669.153325] Starting subtest: x-tiled-64bpp-rotate-180 [670.811533] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.657s) [670.980476] [131/132] (386s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [671.081179] Starting subtest: psr-2p-scndscrn-cur-indfb-move [671.085304] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [671.177556] [132/132] (386s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [671.275579] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [671.279176] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [671.369708] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_pwrite_crc results: parsing output: 2/ for test: kms_vblank results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: perf_pmu results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: kms_flip results: parsing output: 7/ for test: i915_power results: parsing output: 8/ for test: kms_dsc results: parsing output: 9/ for test: i915_query results: parsing output: 10/ for test: gem_partial_pwrite_pread results: parsing output: 11/ for test: perf results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: kms_addfb_basic results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: kms_cursor_legacy results: parsing output: 17/ for test: api_intel_bb results: parsing output: 18/ for test: kms_getfb results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: kms_atomic_transition results: parsing output: 21/ for test: i915_module_load results: parsing output: 22/ for test: kms_psr2_sf results: parsing output: 23/ for test: kms_busy results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: vgem_basic results: parsing output: 27/ for test: gem_exec_schedule results: parsing output: 28/ for test: kms_ccs results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: gem_exec_reloc results: parsing output: 31/ for test: kms_color results: parsing output: 32/ for test: kms_psr2_sf results: parsing output: 33/ for test: gem_exec_nop results: parsing output: 34/ for test: gem_render_copy_redux results: parsing output: 35/ for test: perf_pmu results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: kms_cursor_crc results: parsing output: 39/ for test: kms_plane results: parsing output: 40/ for test: core_setmaster results: parsing output: 41/ for test: gem_userptr_blits results: parsing output: 42/ for test: gem_mmap_gtt results: parsing output: 43/ for test: gem_lmem_swapping results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: syncobj_wait results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: api_intel_bb results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_eio results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_pipe_crc_basic results: parsing output: 54/ for test: gem_ctx_sseu results: parsing output: 55/ for test: kms_plane results: parsing output: 56/ for test: kms_chamelium_frames results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_flip results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: kms_flip_scaled_crc results: parsing output: 61/ for test: kms_cursor_edge_walk results: parsing output: 62/ for test: gem_close results: parsing output: 63/ for test: i915_drm_fdinfo results: parsing output: 64/ for test: gem_exec_reloc results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_ctx_persistence results: parsing output: 67/ for test: kms_async_flips results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: gem_exec_store results: parsing output: 71/ for test: gem_pxp results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: prime_vgem results: parsing output: 74/ for test: kms_content_protection results: parsing output: 75/ for test: gem_render_copy results: parsing output: 76/ for test: gem_ppgtt results: parsing output: 77/ for test: kms_plane results: parsing output: 78/ for test: gem_render_copy results: parsing output: 79/ for test: kms_psr results: parsing output: 80/ for test: vgem_slow results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: kms_cursor_legacy results: parsing output: 84/ for test: kms_psr2_sf results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_lease results: parsing output: 88/ for test: gem_exec_schedule results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_invalid_mode results: parsing output: 91/ for test: gem_mmap_gtt results: parsing output: 92/ for test: i915_pm_rc6_residency results: parsing output: 93/ for test: dumb_buffer results: parsing output: 94/ for test: kms_rotation_crc results: parsing output: 95/ for test: kms_sequence results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: gem_wait results: parsing output: 98/ for test: gem_partial_pwrite_pread results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: kms_draw_crc results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_pm_dc results: parsing output: 104/ for test: kms_rotation_crc results: parsing output: 105/ for test: kms_psr results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_exec_suspend results: parsing output: 108/ for test: syncobj_timeline results: parsing output: 109/ for test: gem_workarounds results: parsing output: 110/ for test: gem_softpin results: parsing output: 111/ for test: perf results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_create results: parsing output: 114/ for test: kms_plane_scaling results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: gen9_exec_parse results: parsing output: 117/ for test: vgem_basic results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_chamelium_hpd results: parsing output: 120/ for test: syncobj_wait results: parsing output: 121/ for test: gem_mmap_offset results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: gem_ctx_isolation results: parsing output: 125/ for test: kms_big_fb results: parsing output: 126/ for test: kms_properties results: parsing output: 127/ for test: gem_exec_basic results: parsing output: 128/ for test: gem_exec_balancer results: parsing output: 129/ for test: kms_big_fb results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_frontbuffer_tracking Done.