[57.796947] Initializing watchdogs [57.797418] /dev/watchdog0 [57.811571] [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.816222] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.818863] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.822422] [001/133] (960s left) syncobj_eventfd (invalid-illegal-handle) [57.898196] Starting subtest: invalid-illegal-handle [57.900499] Subtest invalid-illegal-handle: SUCCESS (0.000s) [58.017171] [002/133] (960s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [58.078933] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [58.146116] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-rte) [58.243588] Starting subtest: psr-2p-rte [58.248088] Subtest psr-2p-rte: SKIP (0.000s) [58.348146] [004/133] (960s left) gem_pwrite (basic-random) [58.402037] Subtest basic-random: SKIP (0.000s) [58.455883] [005/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [58.560103] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [62.271828] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.716s) [63.436753] [006/133] (955s left) gem_ctx_shared (q-in-order) [63.513959] Starting subtest: Q-in-order [63.516320] Starting dynamic subtest: rcs0 [63.635219] Dynamic subtest rcs0: SUCCESS (0.119s) [63.648743] Starting dynamic subtest: vcs0 [63.712429] Dynamic subtest vcs0: SUCCESS (0.079s) [63.726496] Starting dynamic subtest: vcs1 [63.788135] Dynamic subtest vcs1: SUCCESS (0.075s) [63.802885] Starting dynamic subtest: vecs0 [63.864698] Dynamic subtest vecs0: SUCCESS (0.076s) [63.879967] Starting dynamic subtest: ccs0 [63.947867] Dynamic subtest ccs0: SUCCESS (0.083s) [63.950779] Subtest Q-in-order: SUCCESS (0.434s) [65.008748] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true [65.012230] [007/133] (953s left) gem_mmap_offset (mmap-boundaries) [65.070915] Starting subtest: mmap-boundaries [65.073284] Starting dynamic subtest: smem0 [65.352244] Dynamic subtest smem0: SUCCESS (0.283s) [65.355427] Subtest mmap-boundaries: SUCCESS (0.283s) [65.467474] [008/133] (953s left) kms_psr (pr-cursor-render) [65.562884] Starting subtest: pr-cursor-render [65.567506] Subtest pr-cursor-render: SKIP (0.000s) [65.648872] [009/133] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [65.745840] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [73.038877] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.296s) [73.147203] [010/133] (945s left) gem_watchdog (default-virtual) [73.228167] Starting subtest: default-virtual [79.506250] Subtest default-virtual: SUCCESS (6.285s) [79.585904] [011/133] (939s left) kms_cursor_edge_walk (256x256-right-edge) [79.679070] Starting subtest: 256x256-right-edge [79.681475] Starting dynamic subtest: pipe-A-eDP-1 [83.095388] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.417s) [83.104675] Starting dynamic subtest: pipe-D-eDP-1 [86.220464] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s) [86.222748] Subtest 256x256-right-edge: SUCCESS (6.541s) [87.043522] [012/133] (931s left) gem_ctx_engines (independent) [87.116620] Starting subtest: independent [87.118882] Starting dynamic subtest: rcs0 [87.247734] Dynamic subtest rcs0: SUCCESS (0.129s) [87.258729] Starting dynamic subtest: bcs0 [87.364444] Dynamic subtest bcs0: SUCCESS (0.116s) [87.375937] Starting dynamic subtest: vcs0 [87.475883] Dynamic subtest vcs0: SUCCESS (0.112s) [87.486731] Starting dynamic subtest: vcs1 [87.605452] Dynamic subtest vcs1: SUCCESS (0.128s) [87.616743] Starting dynamic subtest: vecs0 [87.727404] Dynamic subtest vecs0: SUCCESS (0.121s) [87.736986] Starting dynamic subtest: ccs0 [87.865422] Dynamic subtest ccs0: SUCCESS (0.138s) [87.874943] Starting dynamic subtest: all-engines [88.342637] Dynamic subtest all-engines: SUCCESS (0.477s) [88.344651] Subtest independent: SUCCESS (1.224s) [89.065960] [013/133] (929s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [89.173316] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [89.177436] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [89.279191] [014/133] (929s left) kms_flip (flip-vs-wf_vblank-interruptible) [89.377087] Starting subtest: flip-vs-wf_vblank-interruptible [89.379338] Starting dynamic subtest: A-eDP1 [91.280223] Dynamic subtest A-eDP1: SUCCESS (1.901s) [91.290696] Starting dynamic subtest: B-eDP1 [93.222965] Dynamic subtest B-eDP1: SUCCESS (1.937s) [93.233539] Starting dynamic subtest: C-eDP1 [95.130147] Dynamic subtest C-eDP1: SUCCESS (1.908s) [95.140249] Starting dynamic subtest: D-eDP1 [96.975464] Dynamic subtest D-eDP1: SUCCESS (1.844s) [96.977573] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.600s) [98.198798] [015/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [98.312140] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [98.316857] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [98.411124] [016/133] (920s left) kms_lease (empty-lease) [98.498436] Starting subtest: empty-lease [98.500830] Starting dynamic subtest: pipe-A-eDP-1 [98.503036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [98.514663] Starting dynamic subtest: pipe-B-eDP-1 [98.517019] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [98.525620] Starting dynamic subtest: pipe-C-eDP-1 [98.527869] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [98.535335] Starting dynamic subtest: pipe-D-eDP-1 [98.537546] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [98.539708] Subtest empty-lease: SUCCESS (0.007s) [98.628400] [017/133] (920s left) kms_color_pipeline (plane-lut1d-lut1d) [98.721868] Starting subtest: plane-lut1d-lut1d [98.868138] Starting dynamic subtest: pipe-A-plane-0 [99.034831] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s) [99.044237] Starting dynamic subtest: pipe-A-plane-1 [99.178956] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s) [99.187051] Starting dynamic subtest: pipe-A-plane-2 [99.345545] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [100.502123] Starting dynamic subtest: pipe-B-plane-0 [100.673336] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [100.682822] Starting dynamic subtest: pipe-B-plane-1 [100.840523] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [100.850304] Starting dynamic subtest: pipe-B-plane-2 [100.995237] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [102.140149] Starting dynamic subtest: pipe-C-plane-0 [102.277318] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [102.286985] Starting dynamic subtest: pipe-C-plane-1 [102.422394] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [102.431577] Starting dynamic subtest: pipe-C-plane-2 [102.577279] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [103.774982] Starting dynamic subtest: pipe-D-plane-0 [103.935015] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s) [103.944420] Starting dynamic subtest: pipe-D-plane-1 [104.079262] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s) [104.088129] Starting dynamic subtest: pipe-D-plane-2 [104.246801] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [104.542960] Subtest plane-lut1d-lut1d: SUCCESS (5.821s) [105.354532] [018/133] (913s left) i915_drm_fdinfo (idle) [105.391702] Starting subtest: idle [105.393942] Starting dynamic subtest: rcs0 [105.943802] Dynamic subtest rcs0: SUCCESS (0.552s) [105.954527] Starting dynamic subtest: bcs0 [106.450262] Dynamic subtest bcs0: SUCCESS (0.503s) [106.461346] Starting dynamic subtest: vcs0 [106.955466] Dynamic subtest vcs0: SUCCESS (0.504s) [106.967043] Starting dynamic subtest: vcs1 [107.460883] Dynamic subtest vcs1: SUCCESS (0.504s) [107.471548] Starting dynamic subtest: vecs0 [107.966184] Dynamic subtest vecs0: SUCCESS (0.504s) [107.977336] Starting dynamic subtest: ccs0 [108.471414] Dynamic subtest ccs0: SUCCESS (0.503s) [108.474363] Subtest idle: SUCCESS (3.079s) [108.547693] [019/133] (910s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [110.072779] Starting subtest: modeset-non-lpsp-stress-no-wait [110.124875] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.051s) [110.772715] [020/133] (908s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [110.874962] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [110.886647] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [110.988394] [021/133] (908s left) gem_exec_params (sol-reset-not-gen7) [111.049812] Starting subtest: sol-reset-not-gen7 [111.054883] Subtest sol-reset-not-gen7: SUCCESS (0.002s) [111.163414] [022/133] (908s left) perf (global-sseu-config-invalid) [111.284545] Starting subtest: global-sseu-config-invalid [111.288300] Subtest global-sseu-config-invalid: SKIP (0.000s) [111.327168] [023/133] (907s left) gem_ctx_persistence (legacy-engines-hang) [111.376402] Starting subtest: legacy-engines-hang [111.378743] Starting dynamic subtest: render [111.510969] Dynamic subtest render: SUCCESS (0.134s) [111.522231] Starting dynamic subtest: bsd1 [111.619198] Dynamic subtest bsd1: SUCCESS (0.106s) [111.630050] Starting dynamic subtest: bsd2 [111.715531] Dynamic subtest bsd2: SUCCESS (0.095s) [111.725860] Starting dynamic subtest: blt [111.819505] Dynamic subtest blt: SUCCESS (0.102s) [111.830259] Starting dynamic subtest: vebox [111.926257] Dynamic subtest vebox: SUCCESS (0.105s) [111.928281] Subtest legacy-engines-hang: SUCCESS (0.551s) [112.030861] [024/133] (907s left) kms_selftest (drm_plane_helper) [112.078255] Starting subtest: drm_plane_helper [112.110302] Starting dynamic subtest: drm_test_check_plane_state [112.214998] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.105s) [112.223820] Starting dynamic subtest: drm_test_check_invalid_plane_state [112.321559] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.104s) [112.323344] Subtest drm_plane_helper: SUCCESS (0.243s) [112.481869] [025/133] (906s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [112.591031] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [113.215565] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s) [113.376324] [026/133] (905s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [113.464627] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [113.466897] Starting dynamic subtest: pipe-A-eDP-1 [113.488924] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [113.498257] Starting dynamic subtest: pipe-B-eDP-1 [113.518299] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [113.525818] Starting dynamic subtest: pipe-C-eDP-1 [113.546991] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [113.555923] Starting dynamic subtest: pipe-D-eDP-1 [113.577197] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [113.581479] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s) [115.739483] [027/133] (903s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [115.801916] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [115.905281] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s) [115.995050] [028/133] (903s left) gem_mmap_wc (read) [116.055576] Subtest read: SKIP (0.000s) [116.110396] [029/133] (903s left) i915_pm_rps (fence-order) [116.178702] Starting subtest: fence-order [119.057846] Subtest fence-order: SUCCESS (2.877s) [119.173144] [030/133] (900s left) syncobj_timeline (multi-wait-all-available-submitted) [119.232885] Starting subtest: multi-wait-all-available-submitted [119.235237] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s) [119.332199] [031/133] (900s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [119.427651] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [126.308085] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.882s) [126.448899] [032/133] (893s left) gem_close_race (basic-threads) [126.513919] Starting subtest: basic-threads [127.869130] Subtest basic-threads: SUCCESS (1.355s) [128.059021] [033/133] (891s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip) [128.169129] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip [128.173415] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [128.256493] [034/133] (891s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [128.349089] Starting subtest: extended-pageflip-modeset-hang-oldfb [128.351045] Starting dynamic subtest: pipe-A [136.254771] Dynamic subtest pipe-A: SUCCESS (7.906s) [136.264923] Starting dynamic subtest: pipe-D [144.872136] Dynamic subtest pipe-D: SUCCESS (8.612s) [144.874594] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.524s) [145.713783] [035/133] (874s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [145.824258] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [145.828579] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [145.931296] [036/133] (873s left) gem_render_copy (y-tiled) [145.990402] Starting subtest: y-tiled [145.994359] Subtest y-tiled: SKIP (0.000s) [146.171317] [037/133] (873s left) kms_vblank (query-forked) [146.257663] Starting subtest: query-forked [146.259755] Starting dynamic subtest: pipe-A-eDP-1 [148.071547] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s) [148.086435] Starting dynamic subtest: pipe-D-eDP-1 [150.625345] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s) [150.627309] Subtest query-forked: SUCCESS (4.367s) [151.479876] [038/133] (868s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [151.534922] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [151.537150] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [151.629701] [039/133] (868s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [151.733933] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [156.330653] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.599s) [157.510961] [040/133] (862s left) kms_psr (fbc-pr-suspend) [157.614017] Starting subtest: fbc-pr-suspend [157.618077] Subtest fbc-pr-suspend: SKIP (0.000s) [157.702078] [041/133] (862s left) syncobj_timeline (signal-array) [157.754171] Starting subtest: signal-array [157.756570] Subtest signal-array: SUCCESS (0.000s) [157.848939] [042/133] (862s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [157.940470] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [165.305196] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.368s) [165.452843] [043/133] (854s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [165.501849] Starting subtest: multi-wait-for-submit-submitted-signaled [165.504151] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [165.596205] [044/133] (854s left) kms_flip (flip-vs-absolute-wf_vblank) [165.688567] Starting subtest: flip-vs-absolute-wf_vblank [165.690890] Starting dynamic subtest: A-eDP1 [174.589032] Dynamic subtest A-eDP1: SUCCESS (8.900s) [174.599442] Starting dynamic subtest: B-eDP1 [183.521621] Dynamic subtest B-eDP1: SUCCESS (8.930s) [183.530068] Starting dynamic subtest: C-eDP1 [192.442891] Dynamic subtest C-eDP1: SUCCESS (8.919s) [192.451418] Starting dynamic subtest: D-eDP1 [201.374568] Dynamic subtest D-eDP1: SUCCESS (8.930s) [201.376785] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.688s) [202.613166] [045/133] (817s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [202.717846] Starting subtest: basic-max-pipe-crc-check [202.722439] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [202.770463] [046/133] (817s left) gem_pipe_control_store_loop (fresh-buffer) [202.826033] Starting subtest: fresh-buffer [204.978697] Subtest fresh-buffer: SUCCESS (2.151s) [205.091079] [047/133] (815s left) kms_psr (psr-sprite-mmap-gtt) [205.182653] Starting subtest: psr-sprite-mmap-gtt [205.184850] Starting dynamic subtest: eDP-1 [206.628226] Dynamic subtest eDP-1: SKIP (1.442s) [206.633543] Subtest psr-sprite-mmap-gtt: SKIP (1.444s) [206.811899] [048/133] (813s left) syncobj_wait (single-wait-all-submitted) [206.860387] Starting subtest: single-wait-all-submitted [206.968054] Subtest single-wait-all-submitted: SUCCESS (0.108s) [207.045065] [049/133] (813s left) gem_exec_reloc (basic-write-read-active) [207.112075] Subtest basic-write-read-active: SKIP (0.000s) [207.178408] [050/133] (813s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [207.261683] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [207.266058] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s) [207.347678] [051/133] (813s left) gem_exec_fence (submit-chain) [207.524398] Starting subtest: submit-chain [207.549212] Subtest submit-chain: SUCCESS (0.025s) [208.995052] [052/133] (811s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [209.063658] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [209.067863] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [209.243727] [053/133] (811s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [209.628313] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [210.437432] [054/133] (810s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [210.534737] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [210.538919] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [210.646400] [055/133] (809s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [210.737264] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [217.636380] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.903s) [217.760826] [056/133] (802s left) gem_sync (basic-all) [217.831088] Starting subtest: basic-all [220.060463] Subtest basic-all: SUCCESS (2.240s) [220.247249] [057/133] (800s left) kms_invalid_mode (zero-vdisplay) [220.350939] Starting subtest: zero-vdisplay [220.353177] Starting dynamic subtest: pipe-A-eDP-1 [220.644487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s) [220.654272] Starting dynamic subtest: pipe-B-eDP-1 [220.656421] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [220.665080] Starting dynamic subtest: pipe-C-eDP-1 [220.667238] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [220.678756] Starting dynamic subtest: pipe-D-eDP-1 [220.680928] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [220.683206] Subtest zero-vdisplay: SUCCESS (0.302s) [221.512781] [058/133] (799s left) gem_ccs (ctrl-surf-copy) [221.578523] Starting subtest: ctrl-surf-copy [221.583500] Subtest ctrl-surf-copy: SKIP (0.000s) [221.688197] [059/133] (799s left) kms_addfb_basic (too-wide) [221.786734] Starting subtest: too-wide [221.788804] Subtest too-wide: SUCCESS (0.000s) [221.866939] [060/133] (798s left) gem_workarounds (reset-context) [221.932604] Starting subtest: reset-context [222.155837] Subtest reset-context: SUCCESS (0.226s) [222.282760] [061/133] (798s left) gem_ctx_isolation (preservation-reset) [222.456169] Starting subtest: preservation-reset [222.458952] Starting dynamic subtest: rcs0 [222.763796] Dynamic subtest rcs0: SUCCESS (0.308s) [222.775097] Starting dynamic subtest: bcs0 [223.115193] Dynamic subtest bcs0: SUCCESS (0.350s) [223.126216] Starting dynamic subtest: vcs0 [223.458796] Dynamic subtest vcs0: SUCCESS (0.343s) [223.467927] Starting dynamic subtest: vcs1 [225.244787] Dynamic subtest vcs1: SUCCESS (1.784s) [225.256924] Starting dynamic subtest: vecs0 [227.223468] Dynamic subtest vecs0: SUCCESS (1.978s) [227.235092] Starting dynamic subtest: ccs0 [229.209045] Dynamic subtest ccs0: SUCCESS (1.985s) [229.211691] Subtest preservation-reset: SUCCESS (6.755s) [229.362076] [062/133] (791s left) kms_content_protection (srm) [229.517253] Starting subtest: srm [229.521794] Subtest srm: SKIP (0.004s) [229.635411] [063/133] (791s left) kms_dp_link_training (non-uhbr-sst) [229.719966] Starting subtest: non-uhbr-sst [229.728550] Subtest non-uhbr-sst: SKIP (0.000s) [229.804969] [064/133] (791s left) i915_suspend (forcewake) [229.855630] Starting subtest: forcewake [261.682347] Subtest forcewake: SUCCESS (2.430s) [261.761926] [065/133] (759s left) gem_gpgpu_fill (offset-16x16) [261.830480] Starting subtest: offset-16x16 [261.836710] Subtest offset-16x16: SUCCESS (0.009s) [261.992060] [066/133] (759s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [262.085248] Starting subtest: plane-downscale-factor-0-5-with-modifiers [262.087742] Starting dynamic subtest: pipe-A [262.108485] Dynamic subtest pipe-A: SKIP (0.019s) [262.120495] Starting dynamic subtest: pipe-B [262.139013] Dynamic subtest pipe-B: SKIP (0.031s) [262.149174] Starting dynamic subtest: pipe-C [262.170596] Dynamic subtest pipe-C: SKIP (0.029s) [262.180362] Starting dynamic subtest: pipe-D [262.199136] Dynamic subtest pipe-D: SKIP (0.029s) [262.204064] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.111s) [262.299423] [067/133] (758s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [262.389555] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [262.392420] Starting dynamic subtest: pipe-A [262.412514] Dynamic subtest pipe-A: SKIP (0.018s) [262.423196] Starting dynamic subtest: pipe-B [262.443105] Dynamic subtest pipe-B: SKIP (0.031s) [262.453507] Starting dynamic subtest: pipe-C [262.474195] Dynamic subtest pipe-C: SKIP (0.031s) [262.484250] Starting dynamic subtest: pipe-D [262.507230] Dynamic subtest pipe-D: SKIP (0.031s) [262.512241] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.114s) [262.606259] [068/133] (758s left) kms_addfb_basic (bo-too-small) [262.696890] Starting subtest: bo-too-small [262.699532] Subtest bo-too-small: SUCCESS (0.000s) [262.799841] [069/133] (758s left) prime_self_import (reimport-vs-gem_close-race) [262.838070] Starting subtest: reimport-vs-gem_close-race [267.931757] Subtest reimport-vs-gem_close-race: SUCCESS (5.087s) [268.020283] [070/133] (753s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [268.131266] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [268.133570] Starting dynamic subtest: pipe-A-eDP-1 [268.154941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [268.167696] Starting dynamic subtest: pipe-B-eDP-1 [268.189606] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [268.199352] Starting dynamic subtest: pipe-C-eDP-1 [268.222075] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [268.231580] Starting dynamic subtest: pipe-D-eDP-1 [268.255085] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [268.257332] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [270.391761] [071/133] (750s left) gem_exec_create (legacy) [270.451620] Starting subtest: legacy [270.454613] Starting dynamic subtest: smem [274.275770] Dynamic subtest smem: SUCCESS (3.819s) [274.278898] Subtest legacy: SUCCESS (3.821s) [274.464120] [072/133] (746s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [274.573883] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [274.576294] Starting dynamic subtest: pipe-A-eDP-1 [274.672451] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [274.685362] Starting dynamic subtest: pipe-B-eDP-1 [275.774050] Dynamic subtest pipe-B-eDP-1: SKIP (1.099s) [275.778721] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.201s) [276.950132] [073/133] (744s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [277.047611] Starting subtest: psr2-cursor-plane-update-sf [277.050350] Starting dynamic subtest: pipe-A-eDP-1 [277.610546] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s) [277.623276] Starting dynamic subtest: pipe-B-eDP-1 [278.940550] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.326s) [278.943322] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.899s) [279.813177] [074/133] (741s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [279.911455] Starting subtest: fbc-pr-plane-move-sf-dmg-area [279.916541] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [279.977960] [075/133] (741s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [280.360868] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [281.217196] [076/133] (740s left) gem_exec_flush (basic-uc-pro-default) [281.284207] Starting subtest: basic-uc-pro-default [286.753099] Subtest basic-uc-pro-default: SUCCESS (5.467s) [286.942322] [077/133] (734s left) sysfs_heartbeat_interval (invalid) [287.004607] Starting subtest: invalid [287.007526] Starting dynamic subtest: vecs0 [287.010362] Dynamic subtest vecs0: SUCCESS (0.000s) [287.021591] Starting dynamic subtest: ccs0 [287.024006] Dynamic subtest ccs0: SUCCESS (0.000s) [287.033498] Starting dynamic subtest: vcs0 [287.035706] Dynamic subtest vcs0: SUCCESS (0.000s) [287.045518] Starting dynamic subtest: bcs0 [287.048306] Dynamic subtest bcs0: SUCCESS (0.000s) [287.058306] Starting dynamic subtest: rcs0 [287.060978] Dynamic subtest rcs0: SUCCESS (0.000s) [287.070675] Starting dynamic subtest: vcs1 [287.073533] Dynamic subtest vcs1: SUCCESS (0.000s) [287.076388] Subtest invalid: SUCCESS (0.005s) [287.117081] [078/133] (734s left) gem_exec_schedule (pi-ringfull) [287.300676] Starting subtest: pi-ringfull [287.303287] Starting dynamic subtest: rcs0 [287.351723] Dynamic subtest rcs0: SUCCESS (0.053s) [287.362712] Starting dynamic subtest: bcs0 [287.393403] Dynamic subtest bcs0: SUCCESS (0.040s) [287.403576] Starting dynamic subtest: vcs0 [287.437358] Dynamic subtest vcs0: SUCCESS (0.042s) [287.447401] Starting dynamic subtest: vcs1 [287.474748] Dynamic subtest vcs1: SUCCESS (0.036s) [287.484709] Starting dynamic subtest: vecs0 [287.507950] Dynamic subtest vecs0: SUCCESS (0.033s) [287.518403] Starting dynamic subtest: ccs0 [287.543458] Dynamic subtest ccs0: SUCCESS (0.034s) [287.546080] Subtest pi-ringfull: SUCCESS (0.245s) [287.777812] [079/133] (733s left) sriov_basic (bind-unbind-vf) [287.838975] Starting subtest: bind-unbind-vf [287.841729] Starting dynamic subtest: vf-1 [287.929808] Dynamic subtest vf-1: FAIL (0.018s) [287.941428] Starting dynamic subtest: vf-2 [288.026507] Dynamic subtest vf-2: FAIL (0.004s) [288.038314] Starting dynamic subtest: vf-3 [288.124221] Dynamic subtest vf-3: FAIL (0.003s) [288.134525] Starting dynamic subtest: vf-4 [288.220463] Dynamic subtest vf-4: FAIL (0.003s) [288.231377] Starting dynamic subtest: vf-5 [288.316405] Dynamic subtest vf-5: FAIL (0.004s) [288.326927] Starting dynamic subtest: vf-6 [288.412685] Dynamic subtest vf-6: FAIL (0.004s) [288.423271] Starting dynamic subtest: vf-7 [288.509748] Dynamic subtest vf-7: FAIL (0.003s) [288.518915] Starting dynamic subtest: vf-random [288.605468] Dynamic subtest vf-random: FAIL (0.003s) [288.616472] Starting dynamic subtest: vf-last [288.698304] Dynamic subtest vf-last: FAIL (0.595s) [288.700388] Subtest bind-unbind-vf: FAIL (0.644s) [288.742698] [080/133] (732s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [288.849241] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [295.891677] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.039s) [296.015764] [081/133] (725s left) core_sysfs (read-all-entries) [296.077605] Starting subtest: read-all-entries [296.087624] Subtest read-all-entries: SUCCESS (0.011s) [296.162606] [082/133] (725s left) intel_hwmon (hwmon-read) [296.227495] Subtest hwmon-read: SKIP (0.000s) [296.288007] [083/133] (725s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [296.411943] Starting subtest: cursorA-vs-flipA-atomic [307.526263] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.112s) [308.392327] [084/133] (713s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [308.491374] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [308.493881] Starting dynamic subtest: pipe-A-eDP-1 [308.518634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [308.528847] Starting dynamic subtest: pipe-B-eDP-1 [308.554330] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [308.564195] Starting dynamic subtest: pipe-C-eDP-1 [308.590449] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [308.600532] Starting dynamic subtest: pipe-D-eDP-1 [308.626813] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [308.631618] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s) [310.676861] [085/133] (711s left) kms_feature_discovery (chamelium) [310.771492] Starting subtest: chamelium [310.776946] Subtest chamelium: SKIP (0.000s) [310.845681] [086/133] (711s left) gem_exec_schedule (preempt-queue-contexts-chain) [310.925143] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [311.210743] [087/133] (710s left) gem_exec_fence (syncobj-timeline-signal) [311.748347] Starting subtest: syncobj-timeline-signal [311.753718] Subtest syncobj-timeline-signal: SUCCESS (0.011s) [313.374946] [088/133] (708s left) syncobj_timeline (multi-wait-available-submitted) [313.434167] Starting subtest: multi-wait-available-submitted [313.436938] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [313.529447] [089/133] (708s left) kms_psr (fbc-psr-primary-blt) [313.636315] Starting subtest: fbc-psr-primary-blt [313.638684] Starting dynamic subtest: eDP-1 [313.643453] Dynamic subtest eDP-1: SKIP (0.000s) [313.648110] Subtest fbc-psr-primary-blt: SKIP (0.001s) [313.713427] [090/133] (708s left) kms_pm_dc (dc5-psr) [314.804506] Starting subtest: dc5-psr [317.697713] Subtest dc5-psr: SUCCESS (2.891s) [318.505949] [091/133] (703s left) kms_psr (psr2-dpms) [318.597567] Starting subtest: psr2-dpms [318.600101] Starting dynamic subtest: eDP-1 [321.440938] Dynamic subtest eDP-1: SUCCESS (2.844s) [321.443505] Subtest psr2-dpms: SUCCESS (2.845s) [322.309376] [092/133] (699s left) gem_flink_basic (basic) [322.368525] Starting subtest: basic [322.371341] Subtest basic: SUCCESS (0.000s) [322.468892] [093/133] (699s left) kms_addfb_basic (clobberred-modifier) [322.527411] Starting subtest: clobberred-modifier [322.532476] Subtest clobberred-modifier: SKIP (0.000s) [322.652956] [094/133] (699s left) perf_pmu (init-sema) [322.700435] Starting subtest: init-sema [322.703332] Starting dynamic subtest: rcs0 [322.706105] Dynamic subtest rcs0: SUCCESS (0.001s) [322.719867] Starting dynamic subtest: bcs0 [322.722451] Dynamic subtest bcs0: SUCCESS (0.001s) [322.732328] Starting dynamic subtest: vcs0 [322.734712] Dynamic subtest vcs0: SUCCESS (0.001s) [322.744541] Starting dynamic subtest: vcs1 [322.746961] Dynamic subtest vcs1: SUCCESS (0.001s) [322.756718] Starting dynamic subtest: vecs0 [322.759430] Dynamic subtest vecs0: SUCCESS (0.001s) [322.769242] Starting dynamic subtest: ccs0 [322.771608] Dynamic subtest ccs0: SUCCESS (0.001s) [322.774184] Subtest init-sema: SUCCESS (0.008s) [322.816094] [095/133] (699s left) kms_panel_fitting (legacy) [322.909357] Starting subtest: legacy [322.911881] Starting dynamic subtest: pipe-A-eDP-1 [323.474126] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s) [323.501258] Starting dynamic subtest: pipe-B-eDP-1 [325.127229] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.633s) [325.155240] Starting dynamic subtest: pipe-C-eDP-1 [326.717640] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.569s) [326.743524] Starting dynamic subtest: pipe-D-eDP-1 [328.353117] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.617s) [328.355555] Subtest legacy: SUCCESS (5.446s) [329.538089] [096/133] (692s left) api_intel_bb (bb-with-allocator) [329.597870] Starting subtest: bb-with-allocator [329.603961] Subtest bb-with-allocator: SUCCESS (0.006s) [329.722277] [097/133] (692s left) gen9_exec_parse (batch-invalid-length) [329.781511] Subtest batch-invalid-length: SKIP (0.000s) [329.862360] [098/133] (692s left) gem_mmap_gtt (big-bo-tiledy) [329.910573] Subtest big-bo-tiledY: SKIP (0.000s) [329.971553] [099/133] (692s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [330.084439] Starting subtest: psr-1p-primscrn-cur-indfb-move [337.427448] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.346s) [337.578207] [100/133] (684s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [337.674389] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [337.700463] Starting dynamic subtest: pipe-A-plane-0 [337.989246] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [338.000226] Starting dynamic subtest: pipe-A-plane-3 [338.233196] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s) [339.344856] Starting dynamic subtest: pipe-B-plane-0 [339.647750] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s) [339.658252] Starting dynamic subtest: pipe-B-plane-3 [339.882507] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s) [340.201507] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.527s) [341.035218] [101/133] (681s left) kms_chamelium_color (ctm-max) [341.130158] Subtest ctm-max: SKIP (0.000s) [341.180334] [102/133] (681s left) gem_gtt_cpu_tlb [341.307107] [103/133] (681s left) gem_exec_whisper (basic-contexts) [341.376585] Starting subtest: basic-contexts [347.268144] Subtest basic-contexts: SUCCESS (5.886s) [347.451105] [104/133] (675s left) kms_cursor_crc (cursor-rapid-movement-64x21) [347.642581] Starting subtest: cursor-rapid-movement-64x21 [347.698126] Subtest cursor-rapid-movement-64x21: SKIP (0.051s) [347.922528] [105/133] (674s left) kms_big_fb (y-tiled-32bpp-rotate-90) [348.026599] Starting subtest: y-tiled-32bpp-rotate-90 [348.031440] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [348.122326] [106/133] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [348.217495] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [348.222387] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [348.301968] [107/133] (674s left) perf (invalid-oa-format-id) [348.389122] Starting subtest: invalid-oa-format-id [348.400422] Subtest invalid-oa-format-id: SUCCESS (0.010s) [348.445003] [108/133] (674s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [348.546295] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [348.550550] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [348.657227] [109/133] (674s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [348.752096] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [355.675630] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.924s) [355.802264] [110/133] (667s left) gem_partial_pwrite_pread (write-snoop) [355.866508] Subtest write-snoop: SKIP (0.000s) [355.940478] [111/133] (667s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [356.041094] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [357.063910] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.023s) [357.189030] [112/133] (665s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [357.291600] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [361.326439] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.040s) [362.442860] [113/133] (660s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [362.546571] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [362.552245] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [363.677105] [114/133] (659s left) gem_mmap_gtt (basic-read-write-distinct) [363.735533] Subtest basic-read-write-distinct: SKIP (0.000s) [363.794165] [115/133] (659s left) gem_spin_batch (engines) [363.849726] Starting subtest: engines [363.852444] Starting dynamic subtest: rcs0 [367.089674] Dynamic subtest rcs0: SUCCESS (3.237s) [367.101185] Starting dynamic subtest: bcs0 [370.329706] Dynamic subtest bcs0: SUCCESS (3.238s) [370.342991] Starting dynamic subtest: vcs0 [373.567725] Dynamic subtest vcs0: SUCCESS (3.236s) [373.580711] Starting dynamic subtest: vcs1 [376.806453] Dynamic subtest vcs1: SUCCESS (3.236s) [376.819553] Starting dynamic subtest: vecs0 [380.040688] Dynamic subtest vecs0: SUCCESS (3.231s) [380.053534] Starting dynamic subtest: ccs0 [383.279983] Dynamic subtest ccs0: SUCCESS (3.236s) [383.282545] Subtest engines: SUCCESS (19.436s) [383.507158] [116/133] (639s left) gem_render_copy (linear-to-vebox-y-tiled) [383.570624] Starting subtest: linear-to-vebox-y-tiled [383.575724] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [383.757669] [117/133] (639s left) kms_flip (2x-busy-flip) [383.860953] Starting subtest: 2x-busy-flip [383.873733] Subtest 2x-busy-flip: SKIP (0.011s) [383.999526] [118/133] (639s left) kms_async_flips (test-time-stamp) [384.092489] Starting subtest: test-time-stamp [384.467490] Starting dynamic subtest: pipe-A-eDP-1 [385.254853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s) [385.633581] Starting dynamic subtest: pipe-B-eDP-1 [386.388526] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s) [386.757487] Starting dynamic subtest: pipe-C-eDP-1 [387.515214] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s) [387.886630] Starting dynamic subtest: pipe-D-eDP-1 [388.653170] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s) [388.655873] Subtest test-time-stamp: SUCCESS (4.561s) [389.829343] [119/133] (633s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [389.928631] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [389.931076] Starting dynamic subtest: pipe-A-default-mode [391.089530] Dynamic subtest pipe-A-default-mode: SKIP (1.159s) [391.094548] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.161s) [391.241035] [120/133] (632s left) core_auth (getclient-master-drop) [391.277435] Starting subtest: getclient-master-drop [391.295870] Subtest getclient-master-drop: SUCCESS (0.017s) [391.411361] [121/133] (632s left) kms_flip (dpms-off-confusion) [391.512356] Starting subtest: dpms-off-confusion [391.514611] Starting dynamic subtest: A-eDP1 [400.167273] Dynamic subtest A-eDP1: SUCCESS (8.657s) [400.181984] Starting dynamic subtest: B-eDP1 [408.892488] Dynamic subtest B-eDP1: SUCCESS (8.724s) [408.904976] Starting dynamic subtest: C-eDP1 [417.606273] Dynamic subtest C-eDP1: SUCCESS (8.713s) [417.620038] Starting dynamic subtest: D-eDP1 [426.233631] Dynamic subtest D-eDP1: SUCCESS (8.625s) [426.236402] Subtest dpms-off-confusion: SUCCESS (34.730s) [427.406239] [122/133] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [427.514545] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [427.520538] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [427.615388] [123/133] (595s left) gem_exec_balancer (bonded-true-hang) [427.884171] Starting subtest: bonded-true-hang [427.889497] Subtest bonded-true-hang: SKIP (0.000s) [427.973014] [124/133] (595s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [428.066175] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [428.071350] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [428.150331] [125/133] (595s left) kms_plane_multiple (2x-tiling-none) [428.243472] Starting subtest: 2x-tiling-none [428.248408] Subtest 2x-tiling-none: SKIP (0.000s) [428.330143] [126/133] (595s left) kms_pipe_crc_basic (bad-source) [428.420549] Starting subtest: bad-source [428.422981] Subtest bad-source: SUCCESS (0.000s) [428.492145] [127/133] (595s left) gem_mmap_gtt (cpuset-basic-small-copy) [428.556748] Subtest cpuset-basic-small-copy: SKIP (0.000s) [428.620423] [128/133] (595s left) kms_big_fb (linear-32bpp-rotate-0) [428.729828] Starting subtest: linear-32bpp-rotate-0 [430.296706] Subtest linear-32bpp-rotate-0: SUCCESS (1.567s) [430.410965] [129/133] (593s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [430.509239] Starting subtest: fbc-rgb101010-draw-render [435.132743] Subtest fbc-rgb101010-draw-render: SUCCESS (4.626s) [436.347242] [130/133] (587s left) i915_hangman (engine-engine-error) [436.407505] Starting subtest: engine-engine-error [436.409973] Starting dynamic subtest: rcs0 [438.274602] Dynamic subtest rcs0: SUCCESS (1.866s) [438.288507] Starting dynamic subtest: bcs0 [440.192348] Dynamic subtest bcs0: SUCCESS (1.914s) [440.205148] Starting dynamic subtest: vcs0 [441.280724] Dynamic subtest vcs0: SUCCESS (1.085s) [441.293822] Starting dynamic subtest: vcs1 [443.265167] Dynamic subtest vcs1: SUCCESS (1.981s) [443.279033] Starting dynamic subtest: vecs0 [445.249036] Dynamic subtest vecs0: SUCCESS (1.981s) [445.263994] Starting dynamic subtest: ccs0 [447.234235] Dynamic subtest ccs0: SUCCESS (1.982s) [447.237257] Subtest engine-engine-error: SUCCESS (10.827s) [447.347969] [131/133] (576s left) kms_pwrite_crc [448.950882] [132/133] (574s left) kms_cursor_crc (cursor-offscreen-512x512) [449.266613] Starting subtest: cursor-offscreen-512x512 [449.272109] Subtest cursor-offscreen-512x512: SKIP (0.001s) [449.471214] [133/133] (574s left) gem_ppgtt (blt-vs-render-ctxn) [449.528703] Starting subtest: blt-vs-render-ctxN [482.557838] Subtest blt-vs-render-ctxN: SUCCESS (33.026s) [482.675792] Closing watchdogs results: parsing output: 0/ for test: syncobj_eventfd results: parsing output: 1/ for test: gem_exec_reloc results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_pwrite results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: gem_ctx_shared results: parsing output: 6/ for test: gem_mmap_offset results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_watchdog results: parsing output: 10/ for test: kms_cursor_edge_walk results: parsing output: 11/ for test: gem_ctx_engines results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_lease results: parsing output: 16/ for test: kms_color_pipeline results: parsing output: 17/ for test: i915_drm_fdinfo results: parsing output: 18/ for test: kms_pm_rpm results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: gem_exec_params results: parsing output: 21/ for test: perf results: parsing output: 22/ for test: gem_ctx_persistence results: parsing output: 23/ for test: kms_selftest results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: syncobj_timeline results: parsing output: 27/ for test: gem_mmap_wc results: parsing output: 28/ for test: i915_pm_rps results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_close_race results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: kms_busy results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_render_copy results: parsing output: 36/ for test: kms_vblank results: parsing output: 37/ for test: syncobj_wait results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_timeline results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: syncobj_wait results: parsing output: 43/ for test: kms_flip results: parsing output: 44/ for test: kms_multipipe_modeset results: parsing output: 45/ for test: gem_pipe_control_store_loop results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: syncobj_wait results: parsing output: 48/ for test: gem_exec_reloc results: parsing output: 49/ for test: kms_flip_scaled_crc results: parsing output: 50/ for test: gem_exec_fence results: parsing output: 51/ for test: gem_render_copy results: parsing output: 52/ for test: kms_chamelium_edid results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_sync results: parsing output: 56/ for test: kms_invalid_mode results: parsing output: 57/ for test: gem_ccs results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: gem_workarounds results: parsing output: 60/ for test: gem_ctx_isolation results: parsing output: 61/ for test: kms_content_protection results: parsing output: 62/ for test: kms_dp_link_training results: parsing output: 63/ for test: i915_suspend results: parsing output: 64/ for test: gem_gpgpu_fill results: parsing output: 65/ for test: kms_plane_scaling results: parsing output: 66/ for test: kms_plane_scaling results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: prime_self_import results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: gem_exec_create results: parsing output: 71/ for test: kms_psr2_sf results: parsing output: 72/ for test: kms_psr2_sf results: parsing output: 73/ for test: kms_psr2_sf results: parsing output: 74/ for test: kms_chamelium_hpd results: parsing output: 75/ for test: gem_exec_flush results: parsing output: 76/ for test: sysfs_heartbeat_interval results: parsing output: 77/ for test: gem_exec_schedule results: parsing output: 78/ for test: sriov_basic results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: core_sysfs results: parsing output: 81/ for test: intel_hwmon results: parsing output: 82/ for test: kms_cursor_legacy results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_feature_discovery results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: gem_exec_fence results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_pm_dc results: parsing output: 90/ for test: kms_psr results: parsing output: 91/ for test: gem_flink_basic results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: perf_pmu results: parsing output: 94/ for test: kms_panel_fitting results: parsing output: 95/ for test: api_intel_bb results: parsing output: 96/ for test: gen9_exec_parse results: parsing output: 97/ for test: gem_mmap_gtt results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_plane results: parsing output: 100/ for test: kms_chamelium_color results: parsing output: 101/ for test: gem_gtt_cpu_tlb results: parsing output: 102/ for test: gem_exec_whisper results: parsing output: 103/ for test: kms_cursor_crc results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: perf results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_partial_pwrite_pread results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: gem_mmap_gtt results: parsing output: 114/ for test: gem_spin_batch results: parsing output: 115/ for test: gem_render_copy results: parsing output: 116/ for test: kms_flip results: parsing output: 117/ for test: kms_async_flips results: parsing output: 118/ for test: kms_flip_scaled_crc results: parsing output: 119/ for test: core_auth results: parsing output: 120/ for test: kms_flip results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_exec_balancer results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_plane_multiple results: parsing output: 125/ for test: kms_pipe_crc_basic results: parsing output: 126/ for test: gem_mmap_gtt results: parsing output: 127/ for test: kms_big_fb results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: i915_hangman results: parsing output: 130/ for test: kms_pwrite_crc results: parsing output: 131/ for test: kms_cursor_crc results: parsing output: 132/ for test: gem_ppgtt Done.