[56.865354] Initializing watchdogs
[56.865399]   /dev/watchdog0
[56.880050] [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]
[56.884637] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.886990] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.890745] [001/133] (960s left) kms_cursor_crc (cursor-random-512x512)
[57.176074] Starting subtest: cursor-random-512x512
[57.180631] Subtest cursor-random-512x512: SKIP (0.001s)
[57.327519] [002/133] (960s left) gem_eio (context-create)
[57.502312] Starting subtest: context-create
[57.706223] Subtest context-create: SUCCESS (0.204s)
[57.851369] [003/133] (959s left) kms_frontbuffer_tracking (psr-2p-rte)
[57.955093] Starting subtest: psr-2p-rte
[57.958769] Subtest psr-2p-rte: SKIP (0.000s)
[58.048047] [004/133] (959s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[58.142077] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[58.143628] Starting dynamic subtest: pipe-A-eDP-1
[58.422078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.254s)
[58.431202] Starting dynamic subtest: pipe-B-eDP-1
[59.704474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.279s)
[59.712228] Starting dynamic subtest: pipe-C-eDP-1
[60.916683] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s)
[60.925113] Starting dynamic subtest: pipe-D-eDP-1
[62.160823] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s)
[62.163090] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.001s)
[63.357491] [005/133] (954s left) gem_exec_gttfill (all-engines)
[63.416108] Starting subtest: all-engines
[87.895923] Subtest all-engines: SUCCESS (24.488s)
[88.082235] [006/133] (929s left) gen7_exec_parse (basic-rejected)
[88.184402] Subtest basic-rejected: SKIP (0.000s)
[88.258631] [007/133] (929s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[88.314794] Subtest tiled-to-tiled: SKIP (0.000s)
[88.384438] [008/133] (929s left) syncobj_wait (multi-wait-submitted)
[88.443605] Starting subtest: multi-wait-submitted
[88.545814] Subtest multi-wait-submitted: SUCCESS (0.102s)
[88.622955] [009/133] (929s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[88.674524] Starting subtest: y-tiled-ccs-to-x-tiled
[88.679063] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[88.875216] [010/133] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[88.992615] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[95.964966] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.977s)
[96.131926] [011/133] (921s left) gem_exec_balancer (fairslice)
[96.214555] Starting subtest: fairslice
[99.157316] Subtest fairslice: SUCCESS (2.941s)
[99.469991] [012/133] (918s left) gem_ctx_param (invalid-size-get)
[99.534119] Starting subtest: invalid-size-get
[99.536510] Subtest invalid-size-get: SUCCESS (0.002s)
[99.665509] [013/133] (918s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[99.788116] Starting subtest: short-flip-after-cursor-toggle
[100.764243] Subtest short-flip-after-cursor-toggle: SUCCESS (0.974s)
[101.580352] [014/133] (916s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[101.683440] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[101.685882] Starting dynamic subtest: pipe-A-eDP-1
[101.695531] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.712806] Starting dynamic subtest: pipe-B-eDP-1
[101.722724] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.735558] Starting dynamic subtest: pipe-C-eDP-1
[101.743870] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.751309] Starting dynamic subtest: pipe-D-eDP-1
[101.760565] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.764622] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[103.851203] [015/133] (914s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[103.941300] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[103.943591] Starting dynamic subtest: pipe-A
[104.052628] Dynamic subtest pipe-A: SKIP (0.107s)
[104.061148] Starting dynamic subtest: pipe-B
[105.227242] Dynamic subtest pipe-B: SKIP (1.172s)
[105.235599] Starting dynamic subtest: pipe-C
[106.365801] Dynamic subtest pipe-C: SUCCESS (1.146s)
[106.375436] Starting dynamic subtest: pipe-D
[107.592338] Dynamic subtest pipe-D: SUCCESS (1.225s)
[107.594751] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.652s)
[108.789683] [016/133] (909s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[108.883797] Starting subtest: plane-lut1d-post-ctm3x4
[109.054369] Starting dynamic subtest: pipe-A-plane-0
[109.254629] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[109.263773] Starting dynamic subtest: pipe-A-plane-1
[109.443268] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[109.452121] Starting dynamic subtest: pipe-A-plane-2
[109.598934] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[110.805726] Starting dynamic subtest: pipe-B-plane-0
[110.965088] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[110.974039] Starting dynamic subtest: pipe-B-plane-1
[111.120593] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[111.129732] Starting dynamic subtest: pipe-B-plane-2
[111.276216] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[112.424025] Starting dynamic subtest: pipe-C-plane-0
[112.561225] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[112.570519] Starting dynamic subtest: pipe-C-plane-1
[112.694630] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[112.703603] Starting dynamic subtest: pipe-C-plane-2
[112.850294] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[114.055768] Starting dynamic subtest: pipe-D-plane-0
[114.193459] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[114.201644] Starting dynamic subtest: pipe-D-plane-1
[114.337626] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[114.345972] Starting dynamic subtest: pipe-D-plane-2
[114.493490] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[114.779861] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.894s)
[115.633304] [017/133] (902s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[115.742827] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[115.746685] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[115.812242] [018/133] (902s left) api_intel_allocator (fork-simple-stress)
[115.864650] Starting subtest: fork-simple-stress
[121.262955] Subtest fork-simple-stress: SUCCESS (5.399s)
[121.391111] [019/133] (896s left) gem_reg_read (timestamp-monotonic)
[121.454081] Starting subtest: timestamp-monotonic
[125.861481] Subtest timestamp-monotonic: SUCCESS (4.407s)
[125.932144] [020/133] (892s left) gem_workarounds (reset-fd)
[125.994799] Starting subtest: reset-fd
[126.184243] Subtest reset-fd: SUCCESS (0.190s)
[126.320548] [021/133] (891s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[126.417361] Starting subtest: 2x-flip-vs-modeset-vs-hang
[126.428145] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[126.501574] [022/133] (891s left) gem_exec_endless (dispatch)
[126.567993] Starting subtest: dispatch
[126.570357] Starting dynamic subtest: rcs0
[126.575472] Dynamic subtest rcs0: SUCCESS (0.008s)
[126.586231] Starting dynamic subtest: bcs0
[126.590558] Dynamic subtest bcs0: SUCCESS (0.005s)
[126.598929] Starting dynamic subtest: vcs0
[126.603325] Dynamic subtest vcs0: SUCCESS (0.005s)
[126.611103] Starting dynamic subtest: vcs1
[126.615099] Dynamic subtest vcs1: SUCCESS (0.004s)
[126.622492] Starting dynamic subtest: vecs0
[126.626496] Dynamic subtest vecs0: SUCCESS (0.005s)
[126.633899] Starting dynamic subtest: ccs0
[126.637962] Dynamic subtest ccs0: SUCCESS (0.005s)
[126.639873] Subtest dispatch: SUCCESS (0.035s)
[127.929861] [023/133] (890s left) kms_tiled_display (basic-test-pattern)
[128.041831] Subtest basic-test-pattern: SKIP (0.000s)
[128.084444] [024/133] (890s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[128.176491] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[128.178823] Starting dynamic subtest: pipe-A-default-mode
[130.874843] Dynamic subtest pipe-A-default-mode: SUCCESS (2.698s)
[130.877057] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.700s)
[131.737906] [025/133] (886s left) gem_tiled_partial_pwrite_pread (reads)
[131.800503] Subtest reads: SKIP (0.000s)
[131.867567] [026/133] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[131.963396] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[131.967369] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[132.068638] [027/133] (886s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[132.119685] Starting subtest: etime-single-wait-all-for-submit-submitted
[132.227036] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[132.300857] [028/133] (886s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[132.353355] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[132.355680] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[132.440359] [029/133] (886s left) gem_mmap_offset (bad-flags)
[132.495055] Starting subtest: bad-flags
[132.497280] Subtest bad-flags: SUCCESS (0.000s)
[132.589732] [030/133] (885s left) kms_addfb_basic (bad-pitch-65536)
[132.643012] Starting subtest: bad-pitch-65536
[132.645104] Subtest bad-pitch-65536: SUCCESS (0.000s)
[132.773330] [031/133] (885s left) kms_big_fb (linear-64bpp-rotate-0)
[132.879672] Starting subtest: linear-64bpp-rotate-0
[134.402395] Subtest linear-64bpp-rotate-0: SUCCESS (1.523s)
[134.577725] [032/133] (884s left) kms_atomic_interruptible (legacy-setmode)
[134.673847] Starting subtest: legacy-setmode
[134.676172] Starting dynamic subtest: pipe-A-eDP-1
[141.572501] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.897s)
[141.574749] Subtest legacy-setmode: SUCCESS (6.898s)
[142.436773] [033/133] (876s left) kms_invalid_mode (zero-clock)
[142.533330] Starting subtest: zero-clock
[142.535525] Starting dynamic subtest: pipe-A-eDP-1
[142.819325] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[142.827724] Starting dynamic subtest: pipe-B-eDP-1
[142.829650] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[142.837297] Starting dynamic subtest: pipe-C-eDP-1
[142.839210] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[142.847117] Starting dynamic subtest: pipe-D-eDP-1
[142.849407] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[142.851753] Subtest zero-clock: SUCCESS (0.290s)
[143.660810] [034/133] (875s left) gem_eio (in-flight-external)
[143.897504] Starting subtest: in-flight-external
[144.994120] Subtest in-flight-external: SUCCESS (1.097s)
[145.104732] [035/133] (873s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[145.209331] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[145.877586] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[146.053619] [036/133] (872s left) gem_exec_schedule (in-order)
[146.125719] Starting subtest: in-order
[146.127735] Starting dynamic subtest: rcs0
[146.219503] Dynamic subtest rcs0: SUCCESS (0.101s)
[146.229121] Starting dynamic subtest: vcs0
[146.307633] Dynamic subtest vcs0: SUCCESS (0.087s)
[146.318746] Starting dynamic subtest: vcs1
[146.390263] Dynamic subtest vcs1: SUCCESS (0.083s)
[146.398585] Starting dynamic subtest: vecs0
[146.475701] Dynamic subtest vecs0: SUCCESS (0.084s)
[146.487431] Starting dynamic subtest: ccs0
[146.571816] Dynamic subtest ccs0: SUCCESS (0.095s)
[146.574095] Subtest in-order: SUCCESS (0.455s)
[148.032832] [037/133] (870s left) kms_vblank (wait-forked-busy)
[148.135941] Starting subtest: wait-forked-busy
[148.137833] Starting dynamic subtest: pipe-A-eDP-1
[150.030207] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.894s)
[150.044574] Starting dynamic subtest: pipe-D-eDP-1
[152.623404] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[152.625616] Subtest wait-forked-busy: SUCCESS (4.487s)
[153.432972] [038/133] (865s left) vgem_slow (nohang)
[153.542454] Starting subtest: nohang
[163.955464] Subtest nohang: SUCCESS (10.412s)
[164.017254] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[164.020567] [039/133] (854s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[164.115132] Starting subtest: plane-all-modeset-transition-internal-panels
[164.117443] Starting dynamic subtest: pipe-A-eDP-1
[165.469281] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.352s)
[165.751079] Starting dynamic subtest: pipe-B-eDP-1
[166.801358] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.057s)
[167.074224] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.960s)
[167.954447] [040/133] (851s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[168.047915] Starting subtest: plane-upscale-20x20-with-pixel-format
[168.050297] Starting dynamic subtest: pipe-A
[169.095203] Dynamic subtest pipe-A: SUCCESS (1.050s)
[169.102901] Starting dynamic subtest: pipe-B
[171.226056] Dynamic subtest pipe-B: SUCCESS (2.130s)
[171.234284] Starting dynamic subtest: pipe-C
[172.414533] Dynamic subtest pipe-C: SUCCESS (1.187s)
[172.423132] Starting dynamic subtest: pipe-D
[173.639578] Dynamic subtest pipe-D: SUCCESS (1.224s)
[173.641906] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.594s)
[174.867840] [041/133] (844s left) kms_plane_cursor (primary)
[174.973095] Starting subtest: primary
[174.977553] Starting dynamic subtest: pipe-A-eDP-1-size-64
[177.579700] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.607s)
[177.603870] Starting dynamic subtest: pipe-A-eDP-1-size-128
[180.159654] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.561s)
[180.182848] Starting dynamic subtest: pipe-A-eDP-1-size-256
[182.794074] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.616s)
[183.107641] Starting dynamic subtest: pipe-B-eDP-1-size-64
[186.417459] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.319s)
[186.441901] Starting dynamic subtest: pipe-B-eDP-1-size-128
[189.040419] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.605s)
[189.064119] Starting dynamic subtest: pipe-B-eDP-1-size-256
[191.610102] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[191.925290] Starting dynamic subtest: pipe-C-eDP-1-size-64
[194.897065] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.983s)
[194.923459] Starting dynamic subtest: pipe-C-eDP-1-size-128
[197.097208] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[197.123044] Starting dynamic subtest: pipe-C-eDP-1-size-256
[199.318835] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[199.639876] Starting dynamic subtest: pipe-D-eDP-1-size-64
[202.524065] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.894s)
[202.549073] Starting dynamic subtest: pipe-D-eDP-1-size-128
[204.732185] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[204.758784] Starting dynamic subtest: pipe-D-eDP-1-size-256
[206.943343] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s)
[207.256298] Subtest primary: SUCCESS (32.282s)
[208.056203] [042/133] (811s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[208.146043] Starting subtest: plane-primary-toggle-with-vblank-wait
[208.148309] Starting dynamic subtest: pipe-A-eDP-1
[208.318142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[208.637704] Starting dynamic subtest: pipe-B-eDP-1
[209.566414] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.939s)
[209.874824] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.731s)
[210.722809] [043/133] (808s left) syncobj_timeline (invalid-query-illegal-handle)
[210.780377] Starting subtest: invalid-query-illegal-handle
[210.782805] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[210.872822] [044/133] (808s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[210.959844] Starting subtest: fbc-dirtyfb-ioctl
[210.961694] Starting dynamic subtest: A-eDP-1
[213.588917] Dynamic subtest A-eDP-1: SUCCESS (2.630s)
[213.591141] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.631s)
[214.391218] [045/133] (804s left) kms_addfb_basic (invalid-get-prop)
[214.451466] Starting subtest: invalid-get-prop
[214.453364] Subtest invalid-get-prop: SUCCESS (0.000s)
[214.608416] [046/133] (804s left) syncobj_wait (wait-for-submit-snapshot)
[214.665776] Starting subtest: wait-for-submit-snapshot
[214.745902] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[214.822732] [047/133] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[214.923062] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[214.927057] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[215.018457] [048/133] (804s left) i915_drm_fdinfo (memory-info-active)
[215.060234] Starting subtest: memory-info-active
[215.062287] Starting dynamic subtest: smem0
[217.819769] Dynamic subtest smem0: SUCCESS (2.760s)
[217.821977] Subtest memory-info-active: SUCCESS (2.761s)
[217.895335] [049/133] (801s left) api_intel_bb (object-noreloc-purge-cache-simple)
[217.951539] Starting subtest: object-noreloc-purge-cache-simple
[217.958545] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s)
[218.082322] [050/133] (801s left) kms_psr (psr-cursor-mmap-gtt)
[218.167996] Starting subtest: psr-cursor-mmap-gtt
[218.169877] Starting dynamic subtest: eDP-1
[219.888924] Dynamic subtest eDP-1: SUCCESS (1.718s)
[219.890809] Subtest psr-cursor-mmap-gtt: SUCCESS (1.719s)
[220.758245] [051/133] (798s left) kms_pipe_crc_basic (suspend-read-crc)
[220.848079] Starting subtest: suspend-read-crc
[220.849895] Starting dynamic subtest: pipe-A-eDP-1
[238.715680] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.142s)
[238.725433] Starting dynamic subtest: pipe-B-eDP-1
[257.750382] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.577s)
[257.760297] Starting dynamic subtest: pipe-C-eDP-1
[276.681991] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.510s)
[276.691753] Starting dynamic subtest: pipe-D-eDP-1
[295.680748] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.445s)
[295.683081] Subtest suspend-read-crc: SUCCESS (13.681s)
[305.545253] [052/133] (723s left) kms_chamelium_hpd (hdmi-hpd-fast)
[305.947765] Subtest hdmi-hpd-fast: SKIP (0.000s)
[306.712236] [053/133] (721s left) kms_cursor_crc (cursor-tearing-position-change)
[306.822661] Starting subtest: cursor-tearing-position-change
[306.824967] Starting dynamic subtest: pipe-A-eDP-1
[307.378950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[307.389547] Starting dynamic subtest: pipe-D-eDP-1
[308.641485] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s)
[308.643913] Subtest cursor-tearing-position-change: SUCCESS (1.846s)
[309.477252] [054/133] (719s left) perf (short-reads)
[309.624071] Starting subtest: short-reads
[309.638416] Subtest short-reads: SUCCESS (0.016s)
[309.688192] [055/133] (718s left) kms_chamelium_edid (dp-mode-timings)
[310.077916] Subtest dp-mode-timings: SKIP (0.000s)
[310.876348] [056/133] (717s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[310.969770] Starting subtest: fbc-pr-sprite-mmap-gtt
[310.974251] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[311.047657] [057/133] (717s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[311.141103] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[320.402832] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.318s)
[320.556539] [058/133] (708s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[320.697800] Starting subtest: verify-pxp-key-change-after-suspend-resume
[327.910262] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.231s)
[339.060100] [059/133] (700s left) gem_exec_reloc (basic-cpu-read-noreloc)
[339.129213] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[339.205039] [060/133] (700s left) perf (mi-rpc)
[339.288631] Starting subtest: mi-rpc
[339.292752] Subtest mi-rpc: SKIP (0.000s)
[339.348092] [061/133] (700s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[339.444291] Starting subtest: fbcpsr-tiling-4
[346.588962] Subtest fbcpsr-tiling-4: SUCCESS (7.152s)
[346.706250] [062/133] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[346.795838] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[346.799688] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[346.899905] [063/133] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[346.986814] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[346.990880] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[347.085661] [064/133] (692s left) kms_lease (lease-uevent)
[347.193749] Starting subtest: lease-uevent
[348.201899] Subtest lease-uevent: SUCCESS (1.010s)
[348.279677] [065/133] (691s left) kms_pm_backlight (brightness-with-dpms)
[348.386453] Starting subtest: brightness-with-dpms
[348.433368] Starting dynamic subtest: eDP-1
[350.884152] Dynamic subtest eDP-1: SUCCESS (2.449s)
[350.886645] Subtest brightness-with-dpms: SUCCESS (2.499s)
[351.738498] [066/133] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[351.842972] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[351.847361] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[351.951611] [067/133] (688s left) kms_flip (2x-plain-flip-fb-recreate)
[352.036834] Starting subtest: 2x-plain-flip-fb-recreate
[352.048324] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[352.129144] [068/133] (688s left) gem_wait (await)
[352.191416] Starting subtest: await
[352.193212] Starting dynamic subtest: all-engines
[353.291912] Dynamic subtest all-engines: SUCCESS (1.103s)
[353.309081] Starting dynamic subtest: rcs0
[354.355329] Dynamic subtest rcs0: SUCCESS (1.061s)
[354.374964] Starting dynamic subtest: bcs0
[355.415139] Dynamic subtest bcs0: SUCCESS (1.058s)
[355.433972] Starting dynamic subtest: vcs0
[356.469957] Dynamic subtest vcs0: SUCCESS (1.054s)
[356.487442] Starting dynamic subtest: vcs1
[357.523881] Dynamic subtest vcs1: SUCCESS (1.052s)
[357.540743] Starting dynamic subtest: vecs0
[358.578312] Dynamic subtest vecs0: SUCCESS (1.052s)
[358.596380] Starting dynamic subtest: ccs0
[359.636934] Dynamic subtest ccs0: SUCCESS (1.057s)
[359.639382] Subtest await: SUCCESS (7.453s)
[359.837998] [069/133] (680s left) kms_psr (fbc-psr-primary-page-flip)
[359.936661] Starting subtest: fbc-psr-primary-page-flip
[359.938999] Starting dynamic subtest: eDP-1
[359.943289] Dynamic subtest eDP-1: SKIP (0.000s)
[359.947602] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[360.013718] [070/133] (680s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[360.123090] Starting subtest: 4-tiled-32bpp-rotate-0
[361.445370] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.324s)
[361.570396] [071/133] (678s left) kms_async_flips (async-flip-dpms)
[361.670026] Starting subtest: async-flip-dpms
[362.047469] Starting dynamic subtest: pipe-A-eDP-1
[365.843891] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.797s)
[366.238766] Starting dynamic subtest: pipe-B-eDP-1
[369.019769] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.793s)
[369.412811] Starting dynamic subtest: pipe-C-eDP-1
[372.198108] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.789s)
[372.592348] Starting dynamic subtest: pipe-D-eDP-1
[375.372281] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.785s)
[375.374671] Subtest async-flip-dpms: SUCCESS (13.699s)
[376.558514] [072/133] (663s left) kms_cdclk (mode-transition-all-outputs)
[376.659281] Starting subtest: mode-transition-all-outputs
[376.952043] Subtest mode-transition-all-outputs: SKIP (0.292s)
[377.797256] [073/133] (662s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[377.893034] Starting subtest: fbc-rgb101010-draw-blt
[382.523846] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.630s)
[383.637054] [074/133] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[383.736934] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[390.330599] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.593s)
[390.434701] [075/133] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[390.532990] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[390.537188] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[390.633021] [076/133] (649s left) perf_pmu (gt-awake)
[390.683816] Starting subtest: gt-awake
[399.094785] Subtest gt-awake: SUCCESS (8.408s)
[399.191733] [077/133] (641s left) i915_getparams_basic (basic-eu-total)
[399.245356] Starting subtest: basic-eu-total
[399.249864] Subtest basic-eu-total: SUCCESS (0.000s)
[399.338646] [078/133] (641s left) kms_prop_blob (basic)
[399.397610] Starting subtest: basic
[399.399793] Subtest basic: SUCCESS (0.000s)
[399.501551] [079/133] (641s left) gem_mmap_wc (write-wc-read-gtt)
[399.561359] Subtest write-wc-read-gtt: SKIP (0.000s)
[399.622787] [080/133] (641s left) kms_cursor_crc (cursor-offscreen-128x42)
[399.849592] Starting subtest: cursor-offscreen-128x42
[399.920848] Subtest cursor-offscreen-128x42: SKIP (0.064s)
[400.122720] [081/133] (640s left) kms_psr (pr-sprite-render)
[400.210737] Starting subtest: pr-sprite-render
[400.214424] Subtest pr-sprite-render: SKIP (0.000s)
[400.288677] [082/133] (640s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[400.341914] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[400.448411] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[400.525993] [083/133] (640s left) perf_pmu (semaphore-wait-idle)
[400.574318] Starting subtest: semaphore-wait-idle
[400.576851] Starting dynamic subtest: rcs0
[401.089699] Dynamic subtest rcs0: SUCCESS (0.516s)
[401.119376] Starting dynamic subtest: bcs0
[401.604373] Dynamic subtest bcs0: SUCCESS (0.511s)
[401.617596] Starting dynamic subtest: vcs0
[402.117483] Dynamic subtest vcs0: SUCCESS (0.510s)
[402.130614] Starting dynamic subtest: vcs1
[402.630823] Dynamic subtest vcs1: SUCCESS (0.511s)
[402.643642] Starting dynamic subtest: vecs0
[403.144033] Dynamic subtest vecs0: SUCCESS (0.510s)
[403.157327] Starting dynamic subtest: ccs0
[403.659598] Dynamic subtest ccs0: SUCCESS (0.512s)
[403.662626] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[405.119428] [084/133] (635s left) gem_exec_reloc (basic-cpu)
[405.180550] Subtest basic-cpu: SKIP (0.000s)
[405.252258] [085/133] (635s left) gem_exec_fence (keep-in-fence)
[405.427175] Starting subtest: keep-in-fence
[405.429663] Starting dynamic subtest: rcs0
[405.486807] Dynamic subtest rcs0: SUCCESS (0.060s)
[405.499185] Starting dynamic subtest: bcs0
[405.544369] Dynamic subtest bcs0: SUCCESS (0.055s)
[405.558440] Starting dynamic subtest: vcs0
[407.029816] Dynamic subtest vcs0: SUCCESS (1.481s)
[407.042866] Starting dynamic subtest: vcs1
[409.076672] Dynamic subtest vcs1: SUCCESS (2.043s)
[409.089779] Starting dynamic subtest: vecs0
[411.061464] Dynamic subtest vecs0: SUCCESS (1.982s)
[411.074541] Starting dynamic subtest: ccs0
[411.287304] Dynamic subtest ccs0: SUCCESS (0.225s)
[411.289972] Subtest keep-in-fence: SUCCESS (5.861s)
[413.136633] [086/133] (627s left) gem_exec_whisper (basic-fds-forked)
[413.209017] Starting subtest: basic-fds-forked
[436.913452] Subtest basic-fds-forked: SUCCESS (23.700s)
[437.090515] [087/133] (603s left) gem_ctx_isolation (dirty-create)
[437.149562] Starting subtest: dirty-create
[437.152074] Starting dynamic subtest: rcs0
[437.384666] Dynamic subtest rcs0: SUCCESS (0.235s)
[437.395098] Starting dynamic subtest: bcs0
[437.642587] Dynamic subtest bcs0: SUCCESS (0.257s)
[437.654496] Starting dynamic subtest: vcs0
[437.894538] Dynamic subtest vcs0: SUCCESS (0.251s)
[437.904955] Starting dynamic subtest: vcs1
[439.246298] Dynamic subtest vcs1: SUCCESS (1.351s)
[439.258386] Starting dynamic subtest: vecs0
[441.278610] Dynamic subtest vecs0: SUCCESS (2.031s)
[441.289037] Starting dynamic subtest: ccs0
[443.286813] Dynamic subtest ccs0: SUCCESS (2.007s)
[443.289264] Subtest dirty-create: SUCCESS (6.138s)
[443.547603] [088/133] (597s left) kms_content_protection (lic-type-1)
[443.720437] Starting subtest: lic-type-1
[443.724956] Subtest lic-type-1: SKIP (0.000s)
[443.835158] [089/133] (597s left) gem_exec_create (madvise)
[443.895478] Starting subtest: madvise
[443.897324] Starting dynamic subtest: smem
[464.065977] Dynamic subtest smem: SUCCESS (20.175s)
[464.068641] Subtest madvise: SUCCESS (20.176s)
[464.957345] [090/133] (576s left) kms_prop_blob (invalid-get-prop-any)
[465.014619] Starting subtest: invalid-get-prop-any
[465.016960] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[465.175401] [091/133] (576s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[465.278015] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[465.280259] Starting dynamic subtest: pipe-A-eDP-1
[465.302300] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[465.313851] Starting dynamic subtest: pipe-B-eDP-1
[465.333737] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[465.343062] Starting dynamic subtest: pipe-C-eDP-1
[465.364122] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[465.373625] Starting dynamic subtest: pipe-D-eDP-1
[465.394881] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[465.399158] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[467.541236] [092/133] (573s left) gem_ctx_engines (execute-one)
[467.611492] Starting subtest: execute-one
[469.844039] Subtest execute-one: SUCCESS (2.236s)
[470.126366] [093/133] (571s left) gem_spin_batch (resubmit-new)
[470.178452] Starting subtest: resubmit-new
[470.180827] Starting dynamic subtest: rcs0
[470.192632] Dynamic subtest rcs0: SUCCESS (0.014s)
[470.203796] Starting dynamic subtest: bcs0
[470.206325] Dynamic subtest bcs0: SUCCESS (0.006s)
[470.216567] Starting dynamic subtest: vcs0
[470.219044] Dynamic subtest vcs0: SUCCESS (0.007s)
[470.228769] Starting dynamic subtest: vcs1
[470.230759] Dynamic subtest vcs1: SUCCESS (0.007s)
[470.240781] Starting dynamic subtest: vecs0
[470.242837] Dynamic subtest vecs0: SUCCESS (0.008s)
[470.252397] Starting dynamic subtest: ccs0
[470.254515] Dynamic subtest ccs0: SUCCESS (0.009s)
[470.256638] Subtest resubmit-new: SUCCESS (0.054s)
[472.094818] [094/133] (569s left) gem_ccs (ctrl-surf-copy)
[472.160265] Starting subtest: ctrl-surf-copy
[472.164836] Subtest ctrl-surf-copy: SKIP (0.000s)
[472.269485] [095/133] (569s left) kms_flip (flip-vs-fences)
[472.366622] Starting subtest: flip-vs-fences
[472.370670] Subtest flip-vs-fences: SKIP (0.000s)
[472.476378] [096/133] (569s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[472.571284] Starting subtest: x-tiled-32bpp-rotate-90
[472.592359] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[472.696640] [097/133] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[472.797811] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[472.801770] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[472.887793] [098/133] (568s left) gem_exec_await (wide-all)
[473.103182] Starting subtest: wide-all
[495.833033] Subtest wide-all: SUCCESS (22.734s)
[496.030873] [099/133] (545s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[496.165396] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[496.167687] Starting dynamic subtest: pipe-A-default-mode
[497.285995] Dynamic subtest pipe-A-default-mode: SKIP (1.116s)
[497.290678] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.118s)
[497.442487] [100/133] (544s left) kms_feature_discovery (psr1)
[497.553764] Starting subtest: psr1
[497.555619] Subtest psr1: SUCCESS (0.000s)
[497.629662] [101/133] (544s left) gem_exec_schedule (u-lateslice)
[497.706757] Starting subtest: u-lateslice
[497.708842] Starting dynamic subtest: rcs0
[497.719294] Dynamic subtest rcs0: SUCCESS (0.022s)
[497.730405] Starting dynamic subtest: bcs0
[497.738376] Dynamic subtest bcs0: SUCCESS (0.018s)
[497.748604] Starting dynamic subtest: vcs0
[497.755164] Dynamic subtest vcs0: SUCCESS (0.017s)
[497.764993] Starting dynamic subtest: vcs1
[497.771829] Dynamic subtest vcs1: SUCCESS (0.016s)
[497.784878] Starting dynamic subtest: vecs0
[497.789311] Dynamic subtest vecs0: SUCCESS (0.016s)
[497.799029] Starting dynamic subtest: ccs0
[497.805600] Dynamic subtest ccs0: SUCCESS (0.016s)
[497.808347] Subtest u-lateslice: SUCCESS (0.109s)
[499.148147] [102/133] (542s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[499.250255] Starting subtest: psr-1p-primscrn-spr-indfb-move
[506.843676] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.593s)
[506.981451] [103/133] (534s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[507.093711] Starting subtest: invalidate-primary-flip-overlay
[517.861379] Subtest invalidate-primary-flip-overlay: SUCCESS (10.766s)
[517.978807] [104/133] (523s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[518.069642] Starting subtest: psr2-plane-move-sf-dmg-area
[518.071540] Starting dynamic subtest: pipe-A-eDP-1
[522.631672] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.558s)
[522.642985] Starting dynamic subtest: pipe-B-eDP-1
[527.959804] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.326s)
[527.962138] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.888s)
[528.837827] [105/133] (513s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[528.942393] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[533.816567] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.876s)
[534.949829] [106/133] (506s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[535.066697] Starting subtest: basic-flip-after-cursor-atomic
[536.016018] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.948s)
[536.876894] [107/133] (505s left) kms_flip (dpms-vs-vblank-race-interruptible)
[536.970897] Starting subtest: dpms-vs-vblank-race-interruptible
[536.973224] Starting dynamic subtest: A-eDP1
[540.954003] Dynamic subtest A-eDP1: SUCCESS (3.977s)
[540.964688] Starting dynamic subtest: B-eDP1
[545.575969] Dynamic subtest B-eDP1: SUCCESS (4.626s)
[545.586530] Starting dynamic subtest: C-eDP1
[550.202768] Dynamic subtest C-eDP1: SUCCESS (4.623s)
[550.213413] Starting dynamic subtest: D-eDP1
[554.831340] Dynamic subtest D-eDP1: SUCCESS (4.626s)
[554.836255] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.863s)
[555.706357] [108/133] (486s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[555.767622] Starting subtest: y-tiled-to-vebox-yf-tiled
[555.772000] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[555.949238] [109/133] (486s left) perf_pmu (all-busy-check-all)
[555.991354] Starting subtest: all-busy-check-all
[558.005020] Subtest all-busy-check-all: SUCCESS (2.013s)
[558.107431] [110/133] (483s left) i915_pm_rps (thresholds-idle)
[558.173595] Starting subtest: thresholds-idle
[558.178204] Subtest thresholds-idle: SKIP (0.001s)
[558.293061] [111/133] (483s left) kms_flip (modeset-vs-vblank-race)
[558.393816] Starting subtest: modeset-vs-vblank-race
[558.396053] Starting dynamic subtest: A-eDP1
[563.112470] Dynamic subtest A-eDP1: SUCCESS (4.720s)
[563.128129] Starting dynamic subtest: B-eDP1
[567.826673] Dynamic subtest B-eDP1: SUCCESS (4.711s)
[567.840429] Starting dynamic subtest: C-eDP1
[572.526034] Dynamic subtest C-eDP1: SUCCESS (4.696s)
[572.539287] Starting dynamic subtest: D-eDP1
[577.147171] Dynamic subtest D-eDP1: SUCCESS (4.619s)
[577.152364] Subtest modeset-vs-vblank-race: SUCCESS (18.761s)
[578.306001] [112/133] (463s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[578.407238] Starting subtest: psr-rgb565-draw-mmap-gtt
[578.411665] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[578.495721] [113/133] (463s left) dmabuf_sync_file (export-multiwait)
[578.539684] Starting subtest: export-multiwait
[578.541846] Subtest export-multiwait: SUCCESS (0.000s)
[578.594836] [114/133] (463s left) kms_flip (nonexisting-fb)
[578.682656] Starting subtest: nonexisting-fb
[578.684487] Starting dynamic subtest: A-eDP1
[579.888195] Dynamic subtest A-eDP1: SUCCESS (1.207s)
[579.904738] Starting dynamic subtest: B-eDP1
[581.022743] Dynamic subtest B-eDP1: SUCCESS (1.132s)
[581.036737] Starting dynamic subtest: C-eDP1
[582.151591] Dynamic subtest C-eDP1: SUCCESS (1.126s)
[582.165665] Starting dynamic subtest: D-eDP1
[583.273908] Dynamic subtest D-eDP1: SUCCESS (1.119s)
[583.276144] Subtest nonexisting-fb: SUCCESS (4.597s)
[584.444892] [115/133] (457s left) sysfs_timeslice_duration (idempotent)
[584.497251] Starting subtest: idempotent
[584.499562] Starting dynamic subtest: vecs0
[584.501911] Dynamic subtest vecs0: SUCCESS (0.000s)
[584.513633] Starting dynamic subtest: ccs0
[584.515444] Dynamic subtest ccs0: SUCCESS (0.000s)
[584.525318] Starting dynamic subtest: vcs0
[584.527221] Dynamic subtest vcs0: SUCCESS (0.000s)
[584.537075] Starting dynamic subtest: bcs0
[584.538959] Dynamic subtest bcs0: SUCCESS (0.000s)
[584.548848] Starting dynamic subtest: rcs0
[584.550997] Dynamic subtest rcs0: SUCCESS (0.000s)
[584.560636] Starting dynamic subtest: vcs1
[584.562466] Dynamic subtest vcs1: SUCCESS (0.000s)
[584.564287] Subtest idempotent: SUCCESS (0.007s)
[584.607250] [116/133] (457s left) gem_exec_params (invalid-fence-in)
[584.665010] Starting subtest: invalid-fence-in
[584.667372] Subtest invalid-fence-in: SUCCESS (0.000s)
[584.760279] [117/133] (457s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[584.859289] Starting subtest: yf-tiled-64bpp-rotate-180
[584.863788] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[584.966064] [118/133] (457s left) gem_lmem_swapping (verify-random)
[585.008380] Subtest verify-random: SKIP (0.000s)
[585.046932] [119/133] (457s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[585.136906] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[585.139087] Starting dynamic subtest: pipe-A-eDP-1
[585.160793] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[585.172738] Starting dynamic subtest: pipe-B-eDP-1
[585.193635] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[585.203849] Starting dynamic subtest: pipe-C-eDP-1
[585.225471] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[585.237541] Starting dynamic subtest: pipe-D-eDP-1
[585.258215] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[585.262124] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[587.408866] [120/133] (455s left) i915_pm_rpm (system-suspend-devices)
[589.145892] Starting subtest: system-suspend-devices
[596.828966] Subtest system-suspend-devices: SUCCESS (7.686s)
[606.255018] [121/133] (445s left) gem_close_race (basic-threads)
[606.342216] Starting subtest: basic-threads
[607.682222] Subtest basic-threads: SUCCESS (1.344s)
[607.870048] [122/133] (443s left) syncobj_timeline (wait-all-interrupted)
[607.933273] Starting subtest: wait-all-interrupted
[608.033538] Subtest wait-all-interrupted: SUCCESS (0.101s)
[608.112323] [123/133] (443s left) kms_flip (2x-flip-vs-panning-interruptible)
[608.219990] Starting subtest: 2x-flip-vs-panning-interruptible
[608.232666] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[608.320899] [124/133] (443s left) kms_atomic (plane-primary-legacy)
[608.411400] Starting subtest: plane-primary-legacy
[608.413549] Starting dynamic subtest: pipe-A-eDP-1
[608.865716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[608.868077] Subtest plane-primary-legacy: SUCCESS (0.456s)
[609.747389] [125/133] (442s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[609.848287] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[609.852382] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[609.947784] [126/133] (441s left) gem_lmem_swapping (massive-random)
[609.993742] Subtest massive-random: SKIP (0.000s)
[610.051768] [127/133] (441s left) gem_eio (in-flight-internal-10ms)
[610.252342] Starting subtest: in-flight-internal-10ms
[612.152464] Subtest in-flight-internal-10ms: SUCCESS (1.900s)
[612.316107] [128/133] (439s left) kms_busy (extended-pageflip-hang-newfb)
[612.405785] Starting subtest: extended-pageflip-hang-newfb
[612.408072] Starting dynamic subtest: pipe-A
[638.869116] Dynamic subtest pipe-A: SUCCESS (26.462s)
[638.881157] Starting dynamic subtest: pipe-D
[653.889769] Dynamic subtest pipe-D: SUCCESS (15.018s)
[653.892008] Subtest extended-pageflip-hang-newfb: SUCCESS (41.485s)
[654.713908] [129/133] (397s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[654.828292] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[654.832619] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[654.919694] [130/133] (397s left) gem_ctx_persistence (legacy-engines-persistence)
[654.986351] Starting subtest: legacy-engines-persistence
[654.988721] Starting dynamic subtest: render
[655.803606] Dynamic subtest render: SUCCESS (0.816s)
[655.817148] Starting dynamic subtest: bsd1
[656.558603] Dynamic subtest bsd1: SUCCESS (0.752s)
[656.571147] Starting dynamic subtest: bsd2
[657.329618] Dynamic subtest bsd2: SUCCESS (0.768s)
[657.343266] Starting dynamic subtest: blt
[658.081360] Dynamic subtest blt: SUCCESS (0.749s)
[658.093922] Starting dynamic subtest: vebox
[658.875717] Dynamic subtest vebox: SUCCESS (0.792s)
[658.878655] Subtest legacy-engines-persistence: SUCCESS (3.890s)
[658.971213] [131/133] (393s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[659.080603] Starting subtest: y-tiled-8bpp-rotate-0
[659.084889] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[659.175883] [132/133] (392s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[659.278626] Starting subtest: primary-yf-tiled-reflect-x-180
[659.338450] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[659.457082] [133/133] (392s left) kms_vrr (seamless-rr-switch-virtual)
[659.553880] Starting subtest: seamless-rr-switch-virtual
[659.560297] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[659.628723] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_exec_gttfill
results: parsing output: 5/ for test: gen7_exec_parse
results: parsing output: 6/ for test: gem_set_tiling_vs_blt
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gem_ctx_param
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: gem_reg_read
results: parsing output: 19/ for test: gem_workarounds
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_endless
results: parsing output: 22/ for test: kms_tiled_display
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_mmap_offset
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: kms_invalid_mode
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: vgem_slow
results: parsing output: 38/ for test: kms_atomic_transition
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_plane_cursor
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_dirtyfb
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_pipe_crc_basic
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_chamelium_edid
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_pxp
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: kms_pm_backlight
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_wait
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_async_flips
results: parsing output: 71/ for test: kms_cdclk
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: i915_getparams_basic
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: gem_ctx_isolation
results: parsing output: 87/ for test: kms_content_protection
results: parsing output: 88/ for test: gem_exec_create
results: parsing output: 89/ for test: kms_prop_blob
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: gem_ctx_engines
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: gem_ccs
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_await
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_feature_discovery
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr_stress_test
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: i915_pm_rps
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_atomic
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_busy
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_rotation_crc
results: parsing output: 132/ for test: kms_vrr
Done.