[59.909637] Initializing watchdogs
[59.909688]   /dev/watchdog0
[59.924753] [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]
[59.929190] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.931338] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.933285] [001/131] (960s left) kms_psr (fbc-pr-primary-blt)
[60.041283] Starting subtest: fbc-pr-primary-blt
[60.043033] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[60.104507] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[60.205574] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[60.207658] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[60.293630] [003/131] (960s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[60.394454] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[60.395296] Starting dynamic subtest: pipe-A-default-mode
[61.508427] Dynamic subtest pipe-A-default-mode: SKIP (1.113s)
[61.510374] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.114s)
[61.657073] [004/131] (958s left) gem_mmap_gtt (cpuset-big-copy-odd)
[61.699090] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[61.743068] [005/131] (958s left) gem_mmap_offset (mmap-boundaries)
[61.787343] Starting subtest: mmap-boundaries
[61.788583] Starting dynamic subtest: smem0
[62.069629] Dynamic subtest smem0: SUCCESS (0.283s)
[62.070881] Subtest mmap-boundaries: SUCCESS (0.284s)
[62.178291] [006/131] (958s left) kms_cursor_legacy (forked-move)
[62.322937] Starting subtest: forked-move
[62.324034] Starting dynamic subtest: pipe-A
[67.827429] Dynamic subtest pipe-A: SUCCESS (5.458s)
[67.836279] Starting dynamic subtest: pipe-B
[73.370788] Dynamic subtest pipe-B: SUCCESS (5.543s)
[73.381353] Starting dynamic subtest: pipe-C
[78.804730] Dynamic subtest pipe-C: SUCCESS (5.470s)
[78.817603] Starting dynamic subtest: pipe-D
[84.297817] Dynamic subtest pipe-D: SUCCESS (5.459s)
[84.308948] Starting dynamic subtest: all-pipes
[89.821945] Dynamic subtest all-pipes: SUCCESS (5.519s)
[89.823181] Subtest forked-move: SUCCESS (27.453s)
[89.938730] [007/131] (930s left) perf_pmu (busy-idle-check-all)
[89.993314] Starting subtest: busy-idle-check-all
[89.994505] Starting dynamic subtest: rcs0
[90.653448] Dynamic subtest rcs0: SUCCESS (0.660s)
[90.663357] Starting dynamic subtest: bcs0
[91.307816] Dynamic subtest bcs0: SUCCESS (0.653s)
[91.318288] Starting dynamic subtest: vcs0
[92.896454] Dynamic subtest vcs0: SUCCESS (1.578s)
[92.905497] Starting dynamic subtest: vcs1
[94.943888] Dynamic subtest vcs1: SUCCESS (2.046s)
[94.952770] Starting dynamic subtest: vecs0
[96.928901] Dynamic subtest vecs0: SUCCESS (1.984s)
[96.937847] Starting dynamic subtest: ccs0
[97.577207] Dynamic subtest ccs0: SUCCESS (0.657s)
[97.578723] Subtest busy-idle-check-all: SUCCESS (7.585s)
[97.703250] [008/131] (922s left) kms_vblank (query-idle-hang)
[97.789009] Starting subtest: query-idle-hang
[97.789909] Starting dynamic subtest: pipe-A-eDP-1
[124.703467] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.913s)
[124.711893] Starting dynamic subtest: pipe-D-eDP-1
[139.670437] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.965s)
[139.671392] Subtest query-idle-hang: SUCCESS (41.882s)
[140.522056] [009/131] (880s left) gem_ctx_isolation (preservation-reset)
[140.708381] Starting subtest: preservation-reset
[140.709979] Starting dynamic subtest: rcs0
[140.949093] Dynamic subtest rcs0: SUCCESS (0.250s)
[140.957605] Starting dynamic subtest: bcs0
[141.241625] Dynamic subtest bcs0: SUCCESS (0.292s)
[141.251414] Starting dynamic subtest: vcs0
[141.531808] Dynamic subtest vcs0: SUCCESS (0.290s)
[141.541489] Starting dynamic subtest: vcs1
[143.202250] Dynamic subtest vcs1: SUCCESS (1.670s)
[143.211680] Starting dynamic subtest: vecs0
[145.176776] Dynamic subtest vecs0: SUCCESS (1.974s)
[145.186272] Starting dynamic subtest: ccs0
[147.184839] Dynamic subtest ccs0: SUCCESS (2.008s)
[147.186597] Subtest preservation-reset: SUCCESS (6.486s)
[147.317385] [010/131] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[147.442949] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[147.444880] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[147.549924] [011/131] (873s left) api_intel_allocator (fork-simple-once)
[147.596270] Starting subtest: fork-simple-once
[147.612922] Subtest fork-simple-once: SUCCESS (0.017s)
[147.728166] [012/131] (873s left) gem_softpin (allocator-nopin-reserve)
[147.778349] Starting subtest: allocator-nopin-reserve
[147.870827] Subtest allocator-nopin-reserve: SUCCESS (0.091s)
[148.020563] [013/131] (872s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[148.109199] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[149.001330] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.892s)
[149.154791] [014/131] (871s left) kms_plane_cursor (primary)
[149.246984] Starting subtest: primary
[149.248964] Starting dynamic subtest: pipe-A-eDP-1-size-64
[151.791202] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.543s)
[151.814939] Starting dynamic subtest: pipe-A-eDP-1-size-128
[154.381203] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[154.406201] Starting dynamic subtest: pipe-A-eDP-1-size-256
[157.004514] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.606s)
[157.316857] Starting dynamic subtest: pipe-B-eDP-1-size-64
[160.633691] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.324s)
[160.657109] Starting dynamic subtest: pipe-B-eDP-1-size-128
[163.212257] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s)
[163.235994] Starting dynamic subtest: pipe-B-eDP-1-size-256
[165.803571] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.573s)
[166.134761] Starting dynamic subtest: pipe-C-eDP-1-size-64
[169.105224] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.977s)
[169.131443] Starting dynamic subtest: pipe-C-eDP-1-size-128
[171.316901] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[171.344919] Starting dynamic subtest: pipe-C-eDP-1-size-256
[173.538594] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[173.851762] Starting dynamic subtest: pipe-D-eDP-1-size-64
[176.905051] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.060s)
[176.933809] Starting dynamic subtest: pipe-D-eDP-1-size-128
[179.160562] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.236s)
[179.187795] Starting dynamic subtest: pipe-D-eDP-1-size-256
[181.382715] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.203s)
[181.689156] Subtest primary: SUCCESS (32.440s)
[182.533439] [015/131] (838s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[182.615333] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[182.616296] Starting dynamic subtest: pipe-A-eDP-1
[183.047781] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[183.056892] Starting dynamic subtest: pipe-B-eDP-1
[183.064585] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[183.071071] Starting dynamic subtest: pipe-C-eDP-1
[183.079038] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[183.088199] Starting dynamic subtest: pipe-D-eDP-1
[183.095800] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[183.096700] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.449s)
[185.291122] [016/131] (835s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[185.347162] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[185.401553] [017/131] (835s left) kms_psr (psr2-sprite-plane-onoff)
[185.485294] Starting subtest: psr2-sprite-plane-onoff
[185.486114] Starting dynamic subtest: eDP-1
[187.242935] Dynamic subtest eDP-1: SUCCESS (1.758s)
[187.243726] Subtest psr2-sprite-plane-onoff: SUCCESS (1.759s)
[188.060702] [018/131] (832s left) sysfs_timeslice_duration (invalid)
[188.117536] Starting subtest: invalid
[188.118628] Starting dynamic subtest: vecs0
[188.119654] Dynamic subtest vecs0: SUCCESS (0.000s)
[188.127881] Starting dynamic subtest: ccs0
[188.128766] Dynamic subtest ccs0: SUCCESS (0.000s)
[188.135220] Starting dynamic subtest: vcs0
[188.136051] Dynamic subtest vcs0: SUCCESS (0.000s)
[188.142568] Starting dynamic subtest: bcs0
[188.143430] Dynamic subtest bcs0: SUCCESS (0.000s)
[188.149747] Starting dynamic subtest: rcs0
[188.150664] Dynamic subtest rcs0: SUCCESS (0.000s)
[188.157065] Starting dynamic subtest: vcs1
[188.157947] Dynamic subtest vcs1: SUCCESS (0.000s)
[188.158843] Subtest invalid: SUCCESS (0.007s)
[188.210734] [019/131] (832s left) perf (gen8-unprivileged-single-ctx-counters)
[188.326729] Starting subtest: gen8-unprivileged-single-ctx-counters
[188.328399] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[188.367555] [020/131] (832s left) gem_vm_create (create-ext)
[188.427429] Starting subtest: create-ext
[188.431780] Subtest create-ext: SUCCESS (0.006s)
[188.563238] [021/131] (832s left) gem_exec_balancer (parallel-keep-submit-fence)
[188.828308] Starting subtest: parallel-keep-submit-fence
[190.077918] Subtest parallel-keep-submit-fence: SUCCESS (1.252s)
[190.161827] [022/131] (830s left) i915_hangman (error-state-basic)
[190.210676] Starting subtest: error-state-basic
[190.382289] Subtest error-state-basic: SUCCESS (0.171s)
[190.461891] [023/131] (830s left) api_intel_bb (purge-bb)
[190.506932] Starting subtest: purge-bb
[190.509591] Subtest purge-bb: SUCCESS (0.004s)
[190.629524] [024/131] (830s left) gen7_exec_parse (chained-batch)
[190.697642] Subtest chained-batch: SKIP (0.000s)
[190.760831] [025/131] (830s left) kms_flip (2x-flip-vs-dpms)
[190.838967] Starting subtest: 2x-flip-vs-dpms
[190.849842] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[190.921848] [026/131] (830s left) gem_softpin (invalid)
[190.984894] Starting subtest: invalid
[190.991436] Subtest invalid: SUCCESS (0.006s)
[191.106638] [027/131] (830s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[191.201110] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[191.202996] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[191.288970] [028/131] (830s left) syncobj_timeline (invalid-signal-bad-pad)
[191.346238] Starting subtest: invalid-signal-bad-pad
[191.347115] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[191.434632] [029/131] (829s left) gem_exec_fence (nb-await)
[191.612890] Starting subtest: nb-await
[191.613878] Starting dynamic subtest: rcs0
[191.675531] Dynamic subtest rcs0: SUCCESS (0.068s)
[191.685408] Starting dynamic subtest: bcs0
[191.734405] Dynamic subtest bcs0: SUCCESS (0.057s)
[191.744695] Starting dynamic subtest: vcs0
[191.794859] Dynamic subtest vcs0: SUCCESS (0.058s)
[191.806454] Starting dynamic subtest: vcs1
[191.853595] Dynamic subtest vcs1: SUCCESS (0.057s)
[191.864582] Starting dynamic subtest: vecs0
[191.913872] Dynamic subtest vecs0: SUCCESS (0.058s)
[191.924934] Starting dynamic subtest: ccs0
[191.973765] Dynamic subtest ccs0: SUCCESS (0.057s)
[191.975533] Subtest nb-await: SUCCESS (0.368s)
[193.947386] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[193.949455] [030/131] (827s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[194.041781] Starting subtest: fbc-1p-pri-indfb-multidraw
[207.275264] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.234s)
[208.625700] [031/131] (812s left) kms_rotation_crc (sprite-rotation-180)
[208.706335] Starting subtest: sprite-rotation-180
[215.418719] Subtest sprite-rotation-180: SUCCESS (6.714s)
[216.544379] [032/131] (804s left) kms_hdr (bpc-switch-suspend)
[216.632222] Starting subtest: bpc-switch-suspend
[217.730272] Starting dynamic subtest: pipe-A-eDP-1
[237.613770] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.110s)
[237.614771] Subtest bpc-switch-suspend: SUCCESS (6.209s)
[242.777533] [033/131] (783s left) i915_selftest (perf)
[244.571283] Starting subtest: perf
[244.572670] Starting dynamic subtest: engine_cs
[248.905545] Dynamic subtest engine_cs: SUCCESS (4.329s)
[248.913037] Starting dynamic subtest: request
[256.228532] Dynamic subtest request: SUCCESS (7.316s)
[256.236357] Starting dynamic subtest: migrate
[259.096958] Dynamic subtest migrate: SUCCESS (2.866s)
[259.104414] Starting dynamic subtest: region
[264.757449] Dynamic subtest region: SUCCESS (5.658s)
[264.758560] Subtest perf: SUCCESS (20.175s)
[264.777961] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[264.778699] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[264.780349] [034/131] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[266.374500] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[266.376242] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[266.487556] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[266.488820] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)] new: kernel.kmod_is_loaded.i915: true
[266.491856] [035/131] (760s left) kms_cursor_crc (cursor-offscreen-32x10)
[266.672342] Starting subtest: cursor-offscreen-32x10
[266.731378] Subtest cursor-offscreen-32x10: SKIP (0.057s)
[266.988226] [036/131] (759s left) kms_psr (psr-sprite-mmap-gtt)
[267.081333] Starting subtest: psr-sprite-mmap-gtt
[267.082182] Starting dynamic subtest: eDP-1
[268.536502] Dynamic subtest eDP-1: SKIP (1.443s)
[268.538452] Subtest psr-sprite-mmap-gtt: SKIP (1.446s)
[268.702438] [037/131] (757s left) kms_color_pipeline (plane-ctm3x4)
[268.790847] Starting subtest: plane-ctm3x4
[268.970881] Starting dynamic subtest: pipe-A-plane-0
[269.115087] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[269.122790] Starting dynamic subtest: pipe-A-plane-1
[269.315720] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[269.329340] Starting dynamic subtest: pipe-A-plane-2
[269.470919] Dynamic subtest pipe-A-plane-2: SUCCESS (0.154s)
[270.673260] Starting dynamic subtest: pipe-B-plane-0
[270.833567] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[270.840729] Starting dynamic subtest: pipe-B-plane-1
[271.000541] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[271.009008] Starting dynamic subtest: pipe-B-plane-2
[271.167045] Dynamic subtest pipe-B-plane-2: SUCCESS (0.164s)
[272.386894] Starting dynamic subtest: pipe-C-plane-0
[272.513663] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[272.524507] Starting dynamic subtest: pipe-C-plane-1
[272.647407] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[272.654446] Starting dynamic subtest: pipe-C-plane-2
[272.769348] Dynamic subtest pipe-C-plane-2: SUCCESS (0.121s)
[274.028641] Starting dynamic subtest: pipe-D-plane-0
[274.154619] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[274.162022] Starting dynamic subtest: pipe-D-plane-1
[274.276953] Dynamic subtest pipe-D-plane-1: SUCCESS (0.121s)
[274.285769] Starting dynamic subtest: pipe-D-plane-2
[274.399199] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s)
[274.683498] Subtest plane-ctm3x4: SUCCESS (5.893s)
[275.596610] [038/131] (751s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[275.679382] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[275.706394] Starting dynamic subtest: pipe-A-plane-0
[276.006035] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[276.014635] Starting dynamic subtest: pipe-A-plane-3
[276.250637] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s)
[277.370176] Starting dynamic subtest: pipe-B-plane-0
[277.674045] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[277.681368] Starting dynamic subtest: pipe-B-plane-3
[277.907326] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[278.229477] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.550s)
[279.034362] [039/131] (747s left) kms_getfb (getfb-handle-zero)
[279.123347] Starting subtest: getfb-handle-zero
[279.124206] Subtest getfb-handle-zero: SUCCESS (0.000s)
[279.242719] [040/131] (747s left) perf_pmu (frequency)
[279.279736] Starting subtest: frequency
[279.283160] Starting dynamic subtest: gt0
[281.412842] Dynamic subtest gt0: SUCCESS (2.126s)
[281.422393] Starting dynamic subtest: idle-gt0
[281.927928] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[281.937479] Starting dynamic subtest: gt1
[286.675723] Dynamic subtest gt1: SUCCESS (4.743s)
[286.685471] Starting dynamic subtest: idle-gt1
[287.181456] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[287.182575] Subtest frequency: SUCCESS (7.895s)
[287.270828] [041/131] (739s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[287.358803] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[291.046494] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.687s)
[292.234243] [042/131] (734s left) sw_sync (sync_multi_consumer_producer)
[292.271258] Starting subtest: sync_multi_consumer_producer
[292.532619] Subtest sync_multi_consumer_producer: SUCCESS (0.254s)
[292.579288] [043/131] (734s left) kms_flip (2x-flip-vs-fences-interruptible)
[292.671319] Starting subtest: 2x-flip-vs-fences-interruptible
[292.679667] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[292.762405] [044/131] (734s left) perf (oa-formats)
[292.885020] Starting subtest: oa-formats
[292.885850] Starting dynamic subtest: 0-rcs0
[292.900436] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[292.910187] Starting dynamic subtest: 1-vecs0
[292.922512] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[292.923397] Subtest oa-formats: SUCCESS (0.039s)
[292.966383] [045/131] (733s left) kms_joiner (basic-force-big-joiner)
[293.053334] Starting subtest: basic-force-big-joiner
[293.054942] Subtest basic-force-big-joiner: SKIP (0.000s)
[293.123852] [046/131] (733s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[293.186275] Starting subtest: yf-tiled-to-vebox-y-tiled
[293.188203] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[293.362592] [047/131] (733s left) dumb_buffer (map-valid)
[293.409044] Starting subtest: map-valid
[293.410102] Subtest map-valid: SUCCESS (0.000s)
[293.504104] [048/131] (733s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[293.595488] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[293.597849] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[293.685905] [049/131] (733s left) kms_flip (2x-flip-vs-expired-vblank)
[293.771275] Starting subtest: 2x-flip-vs-expired-vblank
[293.782755] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[293.892319] [050/131] (733s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[293.979104] Starting subtest: 4-tiled-16bpp-rotate-90
[293.999316] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[294.121585] [051/131] (733s left) kms_getfb (getfb-handle-valid)
[294.216670] Starting subtest: getfb-handle-valid
[294.217676] Subtest getfb-handle-valid: SUCCESS (0.000s)
[294.311481] [052/131] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[294.404514] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[294.406257] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[294.511491] [053/131] (732s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[294.592326] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[294.593145] Starting dynamic subtest: pipe-A-eDP-1
[294.601709] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[294.609600] Starting dynamic subtest: pipe-B-eDP-1
[294.618286] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[294.625753] Starting dynamic subtest: pipe-C-eDP-1
[294.634208] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[294.641574] Starting dynamic subtest: pipe-D-eDP-1
[294.650163] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[294.651721] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[296.874581] [054/131] (730s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[296.962361] Starting subtest: plane-upscale-20x20-with-pixel-format
[296.963324] Starting dynamic subtest: pipe-A
[298.011513] Dynamic subtest pipe-A: SUCCESS (1.050s)
[298.020695] Starting dynamic subtest: pipe-B
[300.097144] Dynamic subtest pipe-B: SUCCESS (2.084s)
[300.106021] Starting dynamic subtest: pipe-C
[301.294154] Dynamic subtest pipe-C: SUCCESS (1.196s)
[301.302929] Starting dynamic subtest: pipe-D
[302.524793] Dynamic subtest pipe-D: SUCCESS (1.229s)
[302.525726] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.563s)
[303.724925] [055/131] (723s left) kms_lease (page-flip-implicit-plane)
[303.811317] Starting subtest: page-flip-implicit-plane
[303.812223] Starting dynamic subtest: pipe-A-eDP-1
[304.305661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.492s)
[304.316247] Starting dynamic subtest: pipe-B-eDP-1
[305.489025] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.183s)
[305.498653] Starting dynamic subtest: pipe-C-eDP-1
[306.607191] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[306.614738] Starting dynamic subtest: pipe-D-eDP-1
[307.727728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[307.728750] Subtest page-flip-implicit-plane: SUCCESS (3.917s)
[308.553885] [056/131] (718s left) kms_flip (2x-flip-vs-suspend)
[308.648013] Starting subtest: 2x-flip-vs-suspend
[308.658998] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[308.734872] [057/131] (718s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[308.846793] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[326.379312] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.528s)
[327.167730] [058/131] (700s left) gen3_render_tiledx_blits
[327.306185] [059/131] (700s left) kms_plane_scaling (2x-scaler-multi-pipe)
[327.412493] Starting subtest: 2x-scaler-multi-pipe
[327.414249] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[327.494205] [060/131] (700s left) gem_exec_schedule (u-semaphore-noskip)
[327.552510] Starting subtest: u-semaphore-noskip
[327.961914] Subtest u-semaphore-noskip: SUCCESS (0.400s)
[328.289293] [061/131] (699s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[328.385918] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[328.387616] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[328.455088] [062/131] (699s left) kms_psr (psr2-basic)
[328.546473] Starting subtest: psr2-basic
[328.547547] Starting dynamic subtest: eDP-1
[330.148227] Dynamic subtest eDP-1: SUCCESS (1.601s)
[330.149028] Subtest psr2-basic: SUCCESS (1.602s)
[330.939881] [063/131] (696s left) kms_pipe_crc_basic (nonblocking-crc)
[331.035031] Starting subtest: nonblocking-crc
[331.035854] Starting dynamic subtest: pipe-A-eDP-1
[331.809243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.773s)
[331.819005] Starting dynamic subtest: pipe-B-eDP-1
[333.257401] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s)
[333.265913] Starting dynamic subtest: pipe-C-eDP-1
[334.628557] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[334.636525] Starting dynamic subtest: pipe-D-eDP-1
[335.972761] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[335.973676] Subtest nonblocking-crc: SUCCESS (4.938s)
[336.783423] [064/131] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[336.869160] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[336.870824] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[336.959428] [065/131] (690s left) gem_exec_reloc (basic-concurrent16)
[337.011035] Subtest basic-concurrent16: SKIP (0.000s)
[337.064200] [066/131] (690s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[337.145499] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[337.146434] Starting dynamic subtest: pipe-A-eDP-1
[337.155852] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[337.168822] Starting dynamic subtest: pipe-B-eDP-1
[337.177028] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[337.189308] Starting dynamic subtest: pipe-C-eDP-1
[337.197794] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[337.204782] Starting dynamic subtest: pipe-D-eDP-1
[337.213823] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[337.215537] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[339.433954] [067/131] (688s left) kms_getfb (getfb-handle-not-fb)
[339.535391] Starting subtest: getfb-handle-not-fb
[339.536301] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[339.618556] [068/131] (688s left) gem_exec_reloc (basic-wc-read-noreloc)
[339.670879] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[339.740410] [069/131] (688s left) syncobj_timeline (multi-wait-available-signaled)
[339.793893] Starting subtest: multi-wait-available-signaled
[339.794747] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[339.888225] [070/131] (687s left) gem_exec_schedule (noreorder)
[340.069983] Starting subtest: noreorder
[340.071068] Starting dynamic subtest: rcs0
[340.115649] Dynamic subtest rcs0: SUCCESS (0.052s)
[340.127146] Starting dynamic subtest: vcs0
[341.720791] Dynamic subtest vcs0: SUCCESS (1.594s)
[341.730273] Starting dynamic subtest: vcs1
[343.702514] Dynamic subtest vcs1: SUCCESS (1.980s)
[343.712412] Starting dynamic subtest: vecs0
[345.679822] Dynamic subtest vecs0: SUCCESS (1.975s)
[345.689803] Starting dynamic subtest: ccs0
[345.741510] Dynamic subtest ccs0: SUCCESS (0.068s)
[345.742751] Subtest noreorder: SUCCESS (5.681s)
[345.926044] [071/131] (681s left) gem_eio (unwedge-stress)
[346.170521] Starting subtest: unwedge-stress
[346.171423] Starting dynamic subtest: render
[351.079291] Dynamic subtest render: SUCCESS (4.910s)
[351.094286] Starting dynamic subtest: bsd1
[372.742517] Dynamic subtest bsd1: SUCCESS (21.665s)
[372.758295] Starting dynamic subtest: bsd2
[393.179670] Dynamic subtest bsd2: SUCCESS (20.435s)
[393.190279] Starting dynamic subtest: blt
[393.196654] Dynamic subtest blt: SKIP (0.000s)
[393.204956] Starting dynamic subtest: vebox
[415.153776] Dynamic subtest vebox: SUCCESS (21.968s)
[415.154803] Subtest unwedge-stress: SUCCESS (68.986s)
[416.687915] [072/131] (611s left) gem_mmap_gtt (basic-read)
[416.742529] Subtest basic-read: SKIP (0.000s)
[416.798759] [073/131] (611s left) gem_pxp (display-protected-crc)
[416.920754] Starting subtest: display-protected-crc
[418.805843] Subtest display-protected-crc: SUCCESS (1.886s)
[418.907747] [074/131] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[419.014948] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[419.016823] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[419.109549] [075/131] (608s left) gem_lmem_swapping (heavy-multi)
[419.155905] Subtest heavy-multi: SKIP (0.000s)
[419.195306] [076/131] (608s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[419.305323] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[419.306900] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[419.392901] [077/131] (608s left) i915_drm_fdinfo (all-busy-check-all)
[419.429347] Starting subtest: all-busy-check-all
[419.433910] Subtest all-busy-check-all: SKIP (0.004s)
[419.498014] [078/131] (608s left) drm_read (empty-block)
[419.654637] Starting subtest: empty-block
[420.660830] Subtest empty-block: SUCCESS (1.000s)
[420.787255] [079/131] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[420.883363] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[420.885109] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[420.976344] [080/131] (607s left) gem_eio (wait-1us)
[421.194633] Starting subtest: wait-1us
[421.545491] Subtest wait-1us: SUCCESS (0.351s)
[421.667228] [081/131] (606s left) syncobj_timeline (etime-multi-wait-all-submitted)
[421.707885] Starting subtest: etime-multi-wait-all-submitted
[421.817274] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[421.882802] [082/131] (606s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[421.928450] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[421.929352] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[422.027884] [083/131] (606s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[422.133083] Starting subtest: basic-modeset-with-all-modifiers-formats
[422.527228] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[423.314769] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.787s)
[423.325070] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[423.336416] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[423.344117] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[423.358612] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[423.374009] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[423.536809] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.175s)
[423.552580] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[423.558964] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[423.567177] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[423.580958] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[423.588841] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[423.603197] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[423.610659] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[423.625496] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[423.633070] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[423.647692] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[423.655457] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[423.670298] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[423.680206] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[423.692457] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[423.703025] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[423.714336] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[423.722986] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[423.880964] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[423.889749] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[423.903171] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[423.911037] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[423.925477] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[423.933337] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[423.948027] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[423.956047] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[423.969865] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[423.977765] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[423.992101] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[423.999913] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[424.014529] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[424.022335] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[424.036713] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[424.044456] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[424.058790] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[424.066646] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[424.236950] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.178s)
[424.245011] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[424.259114] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[424.267900] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[424.281388] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[424.289163] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[424.303597] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[424.311300] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[424.325805] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[424.333349] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[424.348087] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[424.361173] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[424.370345] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[424.378091] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[424.392604] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[424.400368] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[424.414837] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[424.797128] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.664s)
[425.603061] [084/131] (602s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[425.652286] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[425.772626] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[425.848808] [085/131] (602s left) drm_read (short-buffer-nonblock)
[425.984583] Starting subtest: short-buffer-nonblock
[425.985543] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[426.114591] [086/131] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[426.195477] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[426.197170] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[426.282181] [087/131] (602s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[426.377690] Starting subtest: x-tiled-16bpp-rotate-180
[427.747421] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.370s)
[427.913704] [088/131] (600s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[428.017227] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[428.018955] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[428.113411] [089/131] (600s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[428.196326] Starting subtest: fbc-psr2-sprite-mmap-cpu
[428.197200] Starting dynamic subtest: eDP-1
[428.198889] Dynamic subtest eDP-1: SKIP (0.000s)
[428.200722] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[428.266180] [090/131] (600s left) syncobj_timeline (wait-all-complex)
[428.318673] Starting subtest: wait-all-complex
[428.543494] Subtest wait-all-complex: SUCCESS (0.216s)
[428.605893] [091/131] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[428.701632] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[428.703240] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[428.790629] [092/131] (599s left) kms_chamelium_color (ctm-max)
[428.882584] Subtest ctm-max: SKIP (0.000s)
[428.925074] [093/131] (599s left) gem_exec_params (dr4-dirt)
[428.974158] Starting subtest: DR4-dirt
[428.975039] Subtest DR4-dirt: SUCCESS (0.000s)
[429.074179] [094/131] (599s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[429.206437] Starting subtest: multiplane-atomic-fence-wait
[429.523815] Subtest multiplane-atomic-fence-wait: SUCCESS (0.317s)
[430.633141] [095/131] (598s left) kms_concurrent (multi-plane-atomic-lowres)
[430.723328] Starting subtest: multi-plane-atomic-lowres
[430.724259] Starting dynamic subtest: pipe-A-eDP-1
[431.238051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.514s)
[431.246433] Starting dynamic subtest: pipe-B-eDP-1
[432.466193] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.227s)
[432.474538] Starting dynamic subtest: pipe-C-eDP-1
[433.699220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[433.707314] Starting dynamic subtest: pipe-D-eDP-1
[434.928908] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[434.930168] Subtest multi-plane-atomic-lowres: SUCCESS (4.206s)
[435.750250] [096/131] (592s left) prime_busy (after-wait)
[435.808253] Starting subtest: after-wait
[435.811638] Starting dynamic subtest: rcs0
[435.837346] Dynamic subtest rcs0: SUCCESS (0.026s)
[435.846373] Starting dynamic subtest: bcs0
[435.893708] Dynamic subtest bcs0: SUCCESS (0.048s)
[435.903118] Starting dynamic subtest: vcs0
[435.926381] Dynamic subtest vcs0: SUCCESS (0.040s)
[435.933962] Starting dynamic subtest: vcs1
[435.967491] Dynamic subtest vcs1: SUCCESS (0.040s)
[435.977438] Starting dynamic subtest: vecs0
[436.008959] Dynamic subtest vecs0: SUCCESS (0.041s)
[436.016626] Starting dynamic subtest: ccs0
[436.049554] Dynamic subtest ccs0: SUCCESS (0.039s)
[436.156704] Subtest after-wait: SUCCESS (0.348s)
[436.231510] [097/131] (592s left) gem_mmap_wc (coherency)
[436.291548] Subtest coherency: SKIP (0.000s)
[436.349232] [098/131] (592s left) perf (global-sseu-config-invalid)
[436.438936] Starting subtest: global-sseu-config-invalid
[436.440756] Subtest global-sseu-config-invalid: SKIP (0.000s)
[436.472757] [099/131] (592s left) vgem_basic (dmabuf-fence)
[436.509089] Starting subtest: dmabuf-fence
[436.509931] Subtest dmabuf-fence: SUCCESS (0.001s)
[436.562402] [100/131] (592s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[436.638190] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[436.639067] Starting dynamic subtest: pipe-A
[437.800354] Dynamic subtest pipe-A: SUCCESS (1.163s)
[437.808878] Starting dynamic subtest: pipe-B
[440.105174] Dynamic subtest pipe-B: SUCCESS (2.304s)
[440.114522] Starting dynamic subtest: pipe-C
[441.250222] Dynamic subtest pipe-C: SUCCESS (1.143s)
[441.259644] Starting dynamic subtest: pipe-D
[442.489099] Dynamic subtest pipe-D: SUCCESS (1.237s)
[442.490113] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.852s)
[443.688344] [101/131] (585s left) gem_softpin (evict-active-interruptible)
[443.745380] Starting subtest: evict-active-interruptible
[443.751721] Subtest evict-active-interruptible: SUCCESS (0.006s)
[443.881003] [102/131] (585s left) gem_exec_parallel (fds)
[443.934222] Starting subtest: fds
[443.935211] Starting dynamic subtest: rcs0
[447.360966] Dynamic subtest rcs0: SUCCESS (3.417s)
[447.369654] Starting dynamic subtest: bcs0
[451.521203] Dynamic subtest bcs0: SUCCESS (4.157s)
[451.529440] Starting dynamic subtest: vcs0
[455.915892] Dynamic subtest vcs0: SUCCESS (4.392s)
[455.928527] Starting dynamic subtest: vcs1
[460.007824] Dynamic subtest vcs1: SUCCESS (4.089s)
[460.016419] Starting dynamic subtest: vecs0
[463.999541] Dynamic subtest vecs0: SUCCESS (3.990s)
[464.009697] Starting dynamic subtest: ccs0
[468.206294] Dynamic subtest ccs0: SUCCESS (4.213s)
[468.208489] Subtest fds: SUCCESS (24.273s)
[468.410445] [103/131] (560s left) kms_cursor_edge_walk (128x128-top-bottom)
[468.515443] Starting subtest: 128x128-top-bottom
[468.516599] Starting dynamic subtest: pipe-A-eDP-1
[471.964176] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.449s)
[471.973862] Starting dynamic subtest: pipe-D-eDP-1
[475.079346] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[475.080128] Subtest 128x128-top-bottom: SUCCESS (6.565s)
[475.882513] [104/131] (553s left) perf (blocking)
[475.970772] Starting subtest: blocking
[475.971845] Starting dynamic subtest: 0-rcs0
[486.047982] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[486.059056] Starting dynamic subtest: 1-vcs0
[496.069925] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[496.071189] Subtest blocking: SUCCESS (20.055s)
[496.124279] [105/131] (532s left) kms_pm_rpm (basic-pci-d3-state)
[497.856857] Starting subtest: basic-pci-d3-state
[499.318656] Subtest basic-pci-d3-state: SUCCESS (1.463s)
[499.400162] [106/131] (529s left) gem_render_copy (x-tiled)
[499.461232] Starting subtest: x-tiled
[499.462255] Starting dynamic subtest: smem
[499.506302] Dynamic subtest smem: SUCCESS (0.045s)
[499.507339] Subtest x-tiled: SUCCESS (0.045s)
[499.687627] [107/131] (529s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[499.792137] Starting subtest: fbcpsr-tiling-y
[499.793756] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[499.880295] [108/131] (529s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[499.983172] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[504.199285] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.216s)
[505.392465] [109/131] (523s left) gem_exec_whisper (basic-contexts)
[505.451964] Starting subtest: basic-contexts
[512.374566] Subtest basic-contexts: SUCCESS (6.921s)
[512.559149] [110/131] (516s left) i915_pm_rpm (gem-evict-pwrite)
[514.799028] Starting subtest: gem-evict-pwrite
[514.801070] Subtest gem-evict-pwrite: SKIP (0.000s)
[515.161353] [111/131] (514s left) kms_selftest (drm_dp_mst_helper)
[515.192799] Starting subtest: drm_dp_mst_helper
[515.229912] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[515.337744] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.107s)
[515.347052] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[515.425249] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.087s)
[515.434223] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[515.517943] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.092s)
[515.518797] Subtest drm_dp_mst_helper: SUCCESS (0.326s)
[515.681234] [112/131] (513s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[515.781950] Starting subtest: psr2-cursor-plane-move-continuous-sf
[515.782847] Starting dynamic subtest: pipe-A-eDP-1
[526.129163] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.347s)
[526.139260] Starting dynamic subtest: pipe-B-eDP-1
[537.247037] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.116s)
[537.247873] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.466s)
[538.120436] [113/131] (491s left) gem_pxp (reject-modify-context-protection-off-3)
[538.222771] Starting subtest: reject-modify-context-protection-off-3
[538.223852] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[538.325046] [114/131] (491s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[538.709304] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[539.533896] [115/131] (489s left) gem_exec_balancer (invalid-balancer)
[539.585278] Starting subtest: invalid-balancer
[540.561417] Subtest invalid-balancer: SUCCESS (0.966s)
[540.837109] [116/131] (488s left) gem_ctx_persistence (heartbeat-hang)
[540.903138] Starting subtest: heartbeat-hang
[540.905110] Subtest heartbeat-hang: SKIP (0.000s)
[541.013789] [117/131] (488s left) kms_psr (fbc-psr2-cursor-blt)
[541.103217] Starting subtest: fbc-psr2-cursor-blt
[541.104071] Starting dynamic subtest: eDP-1
[541.106031] Dynamic subtest eDP-1: SKIP (0.000s)
[541.107898] Subtest fbc-psr2-cursor-blt: SKIP (0.002s)
[541.175736] [118/131] (488s left) kms_async_flips (invalid-async-flip)
[541.273557] Starting subtest: invalid-async-flip
[541.668676] Starting dynamic subtest: pipe-A-eDP-1
[542.486326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s)
[542.853058] Starting dynamic subtest: pipe-B-eDP-1
[543.626532] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[543.997621] Starting dynamic subtest: pipe-C-eDP-1
[544.758509] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[545.119757] Starting dynamic subtest: pipe-D-eDP-1
[545.884019] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[545.885937] Subtest invalid-async-flip: SUCCESS (4.613s)
[547.039429] [119/131] (482s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[547.238698] Starting subtest: cursor-rapid-movement-64x21
[547.284895] Subtest cursor-rapid-movement-64x21: SKIP (0.045s)
[547.531188] [120/131] (482s left) gem_userptr_blits (readonly-unsync)
[547.593760] Subtest readonly-unsync: SKIP (0.000s)
[547.722948] [121/131] (481s left) gem_partial_pwrite_pread (reads-uncached)
[547.777058] Subtest reads-uncached: SKIP (0.000s)
[547.829456] [122/131] (481s left) kms_big_fb (linear-32bpp-rotate-270)
[547.921484] Starting subtest: linear-32bpp-rotate-270
[547.941267] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[548.054304] [123/131] (481s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[548.148229] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[548.149043] Starting dynamic subtest: pipe-A-eDP-1
[548.152569] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[548.161272] Starting dynamic subtest: pipe-B-eDP-1
[548.164579] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[548.173123] Starting dynamic subtest: pipe-C-eDP-1
[548.176641] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[548.185313] Starting dynamic subtest: pipe-D-eDP-1
[548.188840] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[548.190577] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[550.409143] [124/131] (479s left) kms_prime (basic-crc-hybrid)
[550.492450] Subtest basic-crc-hybrid: SKIP (0.000s)
[550.588401] [125/131] (479s left) gem_create (hog-create)
[550.631712] Starting subtest: hog-create
[550.632887] Starting dynamic subtest: smem0
[583.699651] Dynamic subtest smem0: SUCCESS (33.057s)
[583.701217] Subtest hog-create: SUCCESS (33.058s)
[583.890993] [126/131] (445s left) syncobj_basic (create-signaled)
[583.938241] Starting subtest: create-signaled
[583.939069] Subtest create-signaled: SUCCESS (0.000s)
[584.039086] [127/131] (445s left) dmabuf_sync_file (export-wait-after-attach)
[584.080487] Starting subtest: export-wait-after-attach
[584.081282] Subtest export-wait-after-attach: SUCCESS (0.001s)
[584.136536] [128/131] (445s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[584.231324] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[590.771907] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.540s)
[590.867606] [129/131] (439s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[590.964781] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[598.023587] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.060s)
[598.132884] [130/131] (431s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[598.230254] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[598.232050] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[598.318768] [131/131] (431s left) kms_chamelium_hpd (dp-hpd-storm)
[598.695070] Subtest dp-hpd-storm: SKIP (0.000s)
[599.542985] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: gem_mmap_offset
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: api_intel_allocator
results: parsing output: 11/ for test: gem_softpin
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_plane_cursor
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_pipe_b_c_ivb
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: sysfs_timeslice_duration
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_vm_create
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: i915_hangman
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: gen7_exec_parse
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: gem_softpin
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_hdr
results: parsing output: 32/ for test: i915_selftest
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_color_pipeline
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: kms_getfb
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: sw_sync
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_joiner
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: dumb_buffer
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_getfb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: gen3_render_tiledx_blits
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_getfb
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: gem_pxp
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_lmem_swapping
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: drm_read
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_eio
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_async_flips
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: drm_read
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_chamelium_color
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: kms_explicit_fence
results: parsing output: 94/ for test: kms_concurrent
results: parsing output: 95/ for test: prime_busy
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: kms_plane_scaling
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: gem_exec_parallel
results: parsing output: 102/ for test: kms_cursor_edge_walk
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: kms_pm_rpm
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: i915_pm_rpm
results: parsing output: 110/ for test: kms_selftest
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: gem_pxp
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: gem_partial_pwrite_pread
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_prime
results: parsing output: 124/ for test: gem_create
results: parsing output: 125/ for test: syncobj_basic
results: parsing output: 126/ for test: dmabuf_sync_file
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_chamelium_hpd
Done.