[52.362719] Initializing watchdogs
[52.362764]   /dev/watchdog0
[52.377507] [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]
[52.381759] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.384439] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.387611] [001/133] (960s left) perf_pmu (frequency)
[52.462242] Starting subtest: frequency
[52.466755] Starting dynamic subtest: gt0
[54.606440] Dynamic subtest gt0: SUCCESS (2.155s)
[54.615324] Starting dynamic subtest: idle-gt0
[55.142136] Dynamic subtest idle-gt0: SUCCESS (0.539s)
[55.150380] Starting dynamic subtest: gt1
[59.923994] Dynamic subtest gt1: SUCCESS (4.803s)
[59.931556] Starting dynamic subtest: idle-gt1
[60.428262] Dynamic subtest idle-gt1: SUCCESS (0.506s)
[60.430951] Subtest frequency: SUCCESS (8.014s)
[60.540231] [002/133] (952s left) kms_lease (page-flip-implicit-plane)
[60.648447] Starting subtest: page-flip-implicit-plane
[60.650872] Starting dynamic subtest: pipe-A-eDP-1
[61.171517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.527s)
[61.179380] Starting dynamic subtest: pipe-B-eDP-1
[62.347445] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s)
[62.356935] Starting dynamic subtest: pipe-C-eDP-1
[63.453958] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[63.463385] Starting dynamic subtest: pipe-D-eDP-1
[64.582797] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[64.585071] Subtest page-flip-implicit-plane: SUCCESS (3.945s)
[65.429355] [003/133] (947s left) syncobj_wait (multi-wait-for-submit-submitted)
[65.484828] Starting subtest: multi-wait-for-submit-submitted
[65.593600] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s)
[65.667174] [004/133] (947s left) gem_mmap_wc (copy)
[65.721983] Subtest copy: SKIP (0.000s)
[65.790932] [005/133] (947s left) perf (create-destroy-userspace-config)
[65.924317] Starting subtest: create-destroy-userspace-config
[65.944432] Subtest create-destroy-userspace-config: SUCCESS (0.020s)
[65.989160] [006/133] (947s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[66.038633] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[66.042966] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[66.221142] [007/133] (946s left) gem_exec_basic (basic)
[66.287657] Starting subtest: basic
[66.289994] Starting dynamic subtest: rcs0-smem
[66.292230] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[66.300220] Starting dynamic subtest: bcs0-smem
[66.302396] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[66.309643] Starting dynamic subtest: vcs0-smem
[66.311876] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[66.319080] Starting dynamic subtest: vcs1-smem
[66.321236] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[66.328232] Starting dynamic subtest: vecs0-smem
[66.330408] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[66.337416] Starting dynamic subtest: ccs0-smem
[66.339632] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[66.341852] Subtest basic: SUCCESS (0.011s)
[67.982807] [008/133] (945s left) gem_flink_basic (basic)
[68.075075] Starting subtest: basic
[68.077499] Subtest basic: SUCCESS (0.001s)
[68.195847] [009/133] (945s left) kms_pm_backlight (fade)
[68.297187] Starting subtest: fade
[68.373184] Starting dynamic subtest: eDP-1
[71.046517] Dynamic subtest eDP-1: SUCCESS (2.676s)
[71.049278] Subtest fade: SUCCESS (2.754s)
[71.843815] [010/133] (941s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[71.940036] Starting subtest: plane-upscale-20x20-with-rotation
[71.942312] Starting dynamic subtest: pipe-A
[72.164252] Dynamic subtest pipe-A: SUCCESS (0.226s)
[72.172723] Starting dynamic subtest: pipe-B
[73.428638] Dynamic subtest pipe-B: SUCCESS (1.265s)
[73.437491] Starting dynamic subtest: pipe-C
[74.765785] Dynamic subtest pipe-C: SUCCESS (1.337s)
[74.775955] Starting dynamic subtest: pipe-D
[76.094832] Dynamic subtest pipe-D: SUCCESS (1.329s)
[76.097230] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.159s)
[77.294744] [011/133] (935s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[77.415075] Starting subtest: protected-encrypted-src-copy-not-readible
[77.530753] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.115s)
[77.649748] [012/133] (935s left) kms_prop_blob (invalid-set-prop)
[77.709748] Starting subtest: invalid-set-prop
[77.711716] Subtest invalid-set-prop: SUCCESS (0.000s)
[77.792202] [013/133] (935s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[77.884554] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[85.039919] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.159s)
[86.183431] [014/133] (927s left) gem_ctx_param (invalid-get-engines)
[86.238809] Starting subtest: invalid-get-engines
[86.241235] Subtest invalid-get-engines: SUCCESS (0.001s)
[86.347542] [015/133] (927s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[86.398673] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[86.457824] [016/133] (927s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[86.553641] Starting subtest: fbc-tiling-linear
[90.289448] Subtest fbc-tiling-linear: SUCCESS (3.738s)
[91.470908] [017/133] (922s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[91.572306] Starting subtest: plane-lut1d-post-ctm3x4
[91.751250] Starting dynamic subtest: pipe-A-plane-0
[91.929610] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[91.943067] Starting dynamic subtest: pipe-A-plane-1
[92.095406] Dynamic subtest pipe-A-plane-1: SUCCESS (0.165s)
[92.104734] Starting dynamic subtest: pipe-A-plane-2
[92.262262] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[93.470423] Starting dynamic subtest: pipe-B-plane-0
[93.630455] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[93.640231] Starting dynamic subtest: pipe-B-plane-1
[93.796697] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[93.806205] Starting dynamic subtest: pipe-B-plane-2
[93.985812] Dynamic subtest pipe-B-plane-2: SUCCESS (0.189s)
[95.173270] Starting dynamic subtest: pipe-C-plane-0
[95.300425] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[95.308717] Starting dynamic subtest: pipe-C-plane-1
[95.458257] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[95.467351] Starting dynamic subtest: pipe-C-plane-2
[95.611560] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[96.820367] Starting dynamic subtest: pipe-D-plane-0
[96.969330] Dynamic subtest pipe-D-plane-0: SUCCESS (0.156s)
[96.978951] Starting dynamic subtest: pipe-D-plane-1
[97.136043] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[97.145191] Starting dynamic subtest: pipe-D-plane-2
[97.291517] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[97.578806] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.007s)
[98.366909] [018/133] (915s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[98.481692] Starting subtest: extended-modeset-hang-newfb-with-reset
[98.483635] Starting dynamic subtest: pipe-A
[114.133291] Dynamic subtest pipe-A: SUCCESS (15.650s)
[114.142678] Starting dynamic subtest: pipe-D
[129.720919] Dynamic subtest pipe-D: SUCCESS (15.586s)
[129.723185] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.241s)
[130.528757] [019/133] (883s left) perf_pmu (busy)
[130.577571] Starting subtest: busy
[130.580135] Starting dynamic subtest: rcs0
[131.174534] Dynamic subtest rcs0: SUCCESS (0.599s)
[131.194394] Starting dynamic subtest: bcs0
[131.740464] Dynamic subtest bcs0: SUCCESS (0.564s)
[131.751859] Starting dynamic subtest: vcs0
[132.884705] Dynamic subtest vcs0: SUCCESS (1.142s)
[132.896074] Starting dynamic subtest: vcs1
[134.933420] Dynamic subtest vcs1: SUCCESS (2.046s)
[134.945114] Starting dynamic subtest: vecs0
[136.916650] Dynamic subtest vecs0: SUCCESS (1.982s)
[136.928437] Starting dynamic subtest: ccs0
[137.479829] Dynamic subtest ccs0: SUCCESS (0.562s)
[137.482990] Subtest busy: SUCCESS (6.905s)
[137.585526] [020/133] (876s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[137.687842] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[137.691670] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[137.776337] [021/133] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[137.871482] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[145.420172] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.551s)
[145.543407] [022/133] (868s left) gem_exec_reloc (basic-write-wc)
[145.609564] Subtest basic-write-wc: SKIP (0.000s)
[145.674535] [023/133] (868s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[145.772469] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[145.776604] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[145.857750] [024/133] (867s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[146.248271] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[147.057911] [025/133] (866s left) perf_pmu (rc6)
[147.096097] Starting subtest: rc6
[147.098410] Starting dynamic subtest: gt0
[153.458570] Dynamic subtest gt0: SUCCESS (6.360s)
[153.469693] Starting dynamic subtest: runtime-pm-gt0
[161.233912] Dynamic subtest runtime-pm-gt0: SUCCESS (7.773s)
[161.245187] Starting dynamic subtest: runtime-pm-long-gt0
[173.683567] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.448s)
[173.695730] Starting dynamic subtest: other-idle-gt0
[180.026718] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[180.038863] Starting dynamic subtest: gt1
[186.369091] Dynamic subtest gt1: SUCCESS (6.340s)
[186.379624] Starting dynamic subtest: runtime-pm-gt1
[193.862309] Dynamic subtest runtime-pm-gt1: SUCCESS (7.491s)
[193.874555] Starting dynamic subtest: runtime-pm-long-gt1
[206.301057] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.436s)
[206.314951] Starting dynamic subtest: other-idle-gt1
[212.645303] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[212.648341] Subtest rc6: SUCCESS (65.545s)
[213.754417] [026/133] (800s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[213.817209] Starting subtest: multi-wait-for-submit-available-signaled
[213.819489] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[213.894969] [027/133] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[213.994083] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[213.997702] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[214.054183] [028/133] (799s left) kms_chamelium_edid (dp-edid-read)
[214.438723] Subtest dp-edid-read: SKIP (0.000s)
[215.215625] [029/133] (798s left) gem_blits (basic)
[215.274185] Starting subtest: basic
[216.741338] Subtest basic: SUCCESS (1.467s)
[216.838872] [030/133] (797s left) perf (polling-parameterized)
[216.907706] Starting subtest: polling-parameterized
[236.931278] Subtest polling-parameterized: SUCCESS (20.021s)
[236.983599] [031/133] (777s left) kms_plane (pixel-format-4-tiled-modifier)
[237.091893] Starting subtest: pixel-format-4-tiled-modifier
[237.117729] Starting dynamic subtest: pipe-A-plane-0
[237.773427] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[237.783472] Starting dynamic subtest: pipe-A-plane-3
[238.206025] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[238.214056] Starting dynamic subtest: pipe-A-plane-5
[238.217509] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[239.312111] Starting dynamic subtest: pipe-B-plane-0
[239.950059] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[239.958785] Starting dynamic subtest: pipe-B-plane-3
[240.360795] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[240.369570] Starting dynamic subtest: pipe-B-plane-5
[240.373085] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[240.673130] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.581s)
[241.461371] [032/133] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[241.567584] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[241.571961] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[241.636479] [033/133] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[241.750163] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[241.754524] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[241.834508] [034/133] (772s left) gen3_render_linear_blits
[241.967423] [035/133] (772s left) gem_create (create-ext-set-pat)
[242.129840] Starting subtest: create-ext-set-pat
[242.132358] Subtest create-ext-set-pat: SUCCESS (0.001s)
[242.200580] [036/133] (772s left) syncobj_timeline (single-wait-signaled)
[242.266487] Starting subtest: single-wait-signaled
[242.268484] Subtest single-wait-signaled: SUCCESS (0.000s)
[242.328564] [037/133] (771s left) gem_exec_reloc (basic-gtt-noreloc)
[242.387741] Subtest basic-gtt-noreloc: SKIP (0.000s)
[242.470294] [038/133] (771s left) kms_universal_plane (disable-primary-vs-flip)
[242.559092] Starting subtest: disable-primary-vs-flip
[242.560933] Starting dynamic subtest: pipe-A-eDP-1
[244.189342] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.629s)
[244.198318] Starting dynamic subtest: pipe-B-eDP-1
[246.450469] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.259s)
[246.460152] Starting dynamic subtest: pipe-C-eDP-1
[248.672581] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.222s)
[248.681827] Starting dynamic subtest: pipe-D-eDP-1
[250.870110] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.197s)
[250.872472] Subtest disable-primary-vs-flip: SUCCESS (8.313s)
[251.721528] [039/133] (762s left) gem_exec_schedule (preempt-engines)
[251.791270] Starting subtest: preempt-engines
[251.793518] Starting dynamic subtest: rcs0
[254.100344] Dynamic subtest rcs0: SUCCESS (2.314s)
[254.112029] Starting dynamic subtest: bcs0
[256.328862] Dynamic subtest bcs0: SUCCESS (2.227s)
[256.340592] Starting dynamic subtest: vcs0
[258.622251] Dynamic subtest vcs0: SUCCESS (2.291s)
[258.636759] Starting dynamic subtest: vcs1
[260.899723] Dynamic subtest vcs1: SUCCESS (2.276s)
[260.911712] Starting dynamic subtest: vecs0
[263.181998] Dynamic subtest vecs0: SUCCESS (2.280s)
[263.194164] Starting dynamic subtest: ccs0
[265.482224] Dynamic subtest ccs0: SUCCESS (2.298s)
[265.484801] Subtest preempt-engines: SUCCESS (13.697s)
[265.762323] [040/133] (748s left) gem_exec_balancer (individual)
[265.823533] Starting subtest: individual
[267.923907] Subtest individual: SUCCESS (2.099s)
[268.211325] [041/133] (746s left) gem_wait (invalid-flags)
[268.287091] Starting subtest: invalid-flags
[268.289549] Subtest invalid-flags: SUCCESS (0.000s)
[268.488258] [042/133] (745s left) kms_flip (flip-vs-modeset-vs-hang)
[268.593282] Starting subtest: flip-vs-modeset-vs-hang
[268.595580] Starting dynamic subtest: A-eDP1
[319.344973] Dynamic subtest A-eDP1: SUCCESS (50.749s)
[319.356550] Starting dynamic subtest: D-eDP1
[368.366382] Dynamic subtest D-eDP1: SUCCESS (49.021s)
[368.368675] Subtest flip-vs-modeset-vs-hang: SUCCESS (99.775s)
[368.726951] [043/133] (645s left) vgem_basic (dmabuf-mmap)
[368.833329] Starting subtest: dmabuf-mmap
[368.840158] Subtest dmabuf-mmap: SUCCESS (0.009s)
[368.881143] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[368.884330] [044/133] (645s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[368.946718] Starting subtest: invalid-bsd2-flag-on-blt
[368.948575] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[369.025431] [045/133] (645s left) kms_plane_multiple (2x-tiling-yf)
[369.107264] Starting subtest: 2x-tiling-yf
[369.111475] Subtest 2x-tiling-yf: SKIP (0.000s)
[369.157338] [046/133] (645s left) kms_flip (basic-plain-flip)
[369.250333] Starting subtest: basic-plain-flip
[369.252614] Starting dynamic subtest: A-eDP1
[370.952786] Dynamic subtest A-eDP1: SUCCESS (1.701s)
[370.966156] Starting dynamic subtest: B-eDP1
[372.592706] Dynamic subtest B-eDP1: SUCCESS (1.638s)
[372.607645] Starting dynamic subtest: C-eDP1
[374.233045] Dynamic subtest C-eDP1: SUCCESS (1.638s)
[374.246369] Starting dynamic subtest: D-eDP1
[375.854918] Dynamic subtest D-eDP1: SUCCESS (1.620s)
[375.861297] Subtest basic-plain-flip: SUCCESS (6.610s)
[377.011842] [047/133] (637s left) i915_pm_rps (reset)
[377.080521] Starting subtest: reset
[385.544105] Subtest reset: SUCCESS (8.461s)
[385.638050] [048/133] (629s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[385.746510] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[393.099526] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.356s)
[393.227181] [049/133] (621s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[393.321088] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[393.323260] Starting dynamic subtest: pipe-A-default-mode
[394.510757] Dynamic subtest pipe-A-default-mode: SKIP (1.188s)
[394.515309] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.189s)
[394.623746] [050/133] (620s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[394.720122] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[395.775869] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.057s)
[395.868451] [051/133] (618s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[395.961484] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[395.963405] Starting dynamic subtest: pipe-A-eDP-1
[395.980644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[395.990620] Starting dynamic subtest: pipe-B-eDP-1
[396.008135] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[396.018069] Starting dynamic subtest: pipe-C-eDP-1
[396.034312] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[396.042121] Starting dynamic subtest: pipe-D-eDP-1
[396.059456] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[396.061165] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.011s)
[398.220939] [052/133] (616s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[398.319197] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[398.331061] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[398.387567] [053/133] (616s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[398.959855] Starting subtest: syncobj-timeline-invalid-wait
[398.962791] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[399.949333] [054/133] (615s left) gem_mmap_wc (write-read)
[400.019378] Subtest write-read: SKIP (0.000s)
[400.089126] [055/133] (614s left) kms_psr (pr-primary-mmap-gtt)
[400.193172] Starting subtest: pr-primary-mmap-gtt
[400.197639] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[400.241523] [056/133] (614s left) gem_render_copy_redux (flink-interruptible)
[400.303123] Starting subtest: flink-interruptible
[401.160353] Subtest flink-interruptible: SUCCESS (0.860s)
[401.276922] [057/133] (613s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[401.385940] Starting subtest: basic-flip-after-cursor-atomic
[402.303838] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.917s)
[403.156852] [058/133] (612s left) gen7_exec_parse (bitmasks)
[403.219230] Subtest bitmasks: SKIP (0.000s)
[403.296616] [059/133] (611s left) kms_dp_aux_dev (basic)
[403.354071] Starting subtest: basic
[403.576221] Subtest basic: SUCCESS (0.222s)
[403.625454] [060/133] (611s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[403.709788] Starting subtest: stress-xrgb8888-yftiled
[403.714205] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[403.785704] [061/133] (611s left) gem_exec_parallel (engines)
[403.837759] Starting subtest: engines
[403.840091] Starting dynamic subtest: basic
[405.844567] Dynamic subtest basic: SUCCESS (2.005s)
[405.856532] Starting dynamic subtest: contexts
[410.363046] Dynamic subtest contexts: SUCCESS (4.516s)
[410.375231] Starting dynamic subtest: fds
[414.198865] Dynamic subtest fds: SUCCESS (3.835s)
[414.208057] Starting dynamic subtest: userptr
[415.911061] Dynamic subtest userptr: SUCCESS (1.711s)
[415.913729] Subtest engines: SUCCESS (12.073s)
[416.080173] [062/133] (599s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[416.186213] Starting subtest: 4-tiled-32bpp-rotate-180
[417.664657] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.479s)
[417.774535] [063/133] (597s left) i915_drm_fdinfo (isolation)
[417.814451] Starting subtest: isolation
[417.816270] Starting dynamic subtest: rcs0
[417.848178] Dynamic subtest rcs0: SKIP (0.032s)
[417.859669] Starting dynamic subtest: bcs0
[417.863287] Dynamic subtest bcs0: SKIP (0.000s)
[417.871871] Starting dynamic subtest: vcs0
[417.875357] Dynamic subtest vcs0: SKIP (0.000s)
[417.883969] Starting dynamic subtest: vcs1
[417.887490] Dynamic subtest vcs1: SKIP (0.000s)
[417.895508] Starting dynamic subtest: vecs0
[417.899062] Dynamic subtest vecs0: SKIP (0.000s)
[417.907158] Starting dynamic subtest: ccs0
[417.910741] Dynamic subtest ccs0: SKIP (0.000s)
[417.914296] Subtest isolation: SKIP (0.038s)
[417.948655] [064/133] (597s left) kms_hdr (bpc-switch-suspend)
[418.042643] Starting subtest: bpc-switch-suspend
[419.133227] Starting dynamic subtest: pipe-A-eDP-1
[438.478860] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.466s)
[438.481151] Subtest bpc-switch-suspend: SUCCESS (6.556s)
[438.580626] [065/133] (576s left) perf_pmu (interrupts)
[438.628697] Starting subtest: interrupts
[439.722100] Subtest interrupts: SUCCESS (1.112s)
[439.807605] [066/133] (575s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[439.926986] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[439.931293] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[440.012216] [067/133] (575s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[440.063555] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[440.167891] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[440.224815] [068/133] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[440.318338] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[440.322355] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[440.380424] [069/133] (575s left) api_intel_allocator (open-vm)
[440.431999] Starting subtest: open-vm
[440.434296] Subtest open-vm: SUCCESS (0.004s)
[440.525821] [070/133] (575s left) gem_ctx_param (invalid-size-get)
[440.574322] Starting subtest: invalid-size-get
[440.576534] Subtest invalid-size-get: SUCCESS (0.001s)
[440.649985] [071/133] (575s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[440.750198] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[441.553554] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[441.692056] [072/133] (574s left) gem_partial_pwrite_pread (reads-uncached)
[441.749752] Subtest reads-uncached: SKIP (0.000s)
[441.824518] [073/133] (573s left) kms_flip (flip-vs-expired-vblank)
[441.910757] Starting subtest: flip-vs-expired-vblank
[441.912913] Starting dynamic subtest: A-eDP1
[450.573967] Dynamic subtest A-eDP1: SUCCESS (8.728s)
[450.583860] Starting dynamic subtest: B-eDP1
[459.254536] Dynamic subtest B-eDP1: SUCCESS (8.701s)
[459.274811] Starting dynamic subtest: C-eDP1
[467.955290] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[467.965159] Starting dynamic subtest: D-eDP1
[476.577626] Dynamic subtest D-eDP1: SUCCESS (8.614s)
[476.583266] Subtest flip-vs-expired-vblank: SUCCESS (34.767s)
[477.728875] [074/133] (538s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[477.822055] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[477.834871] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.012s)
[477.890044] [075/133] (537s left) gem_softpin (reverse)
[477.941206] Starting subtest: reverse
[477.946388] Subtest reverse: SUCCESS (0.005s)
[478.055392] [076/133] (537s left) kms_psr (psr-primary-page-flip)
[478.164781] Starting subtest: psr-primary-page-flip
[478.166970] Starting dynamic subtest: eDP-1
[479.947424] Dynamic subtest eDP-1: SUCCESS (1.783s)
[479.949565] Subtest psr-primary-page-flip: SUCCESS (1.784s)
[480.783514] [077/133] (535s left) kms_dsc (dsc-with-output-formats)
[480.878026] Starting subtest: dsc-with-output-formats
[480.899908] Subtest dsc-with-output-formats: SKIP (0.001s)
[480.941433] [078/133] (535s left) kms_pm_rpm (modeset-lpsp)
[482.979213] Starting subtest: modeset-lpsp
[484.457827] Subtest modeset-lpsp: SUCCESS (1.481s)
[484.536672] [079/133] (531s left) kms_vblank (wait-forked-busy-hang)
[484.640780] Starting subtest: wait-forked-busy-hang
[484.643152] Starting dynamic subtest: pipe-A-eDP-1
[511.573831] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.934s)
[511.588219] Starting dynamic subtest: pipe-D-eDP-1
[536.545408] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.974s)
[536.547416] Subtest wait-forked-busy-hang: SUCCESS (51.913s)
[537.337886] [080/133] (478s left) i915_suspend (fence-restore-tiled2untiled)
[537.396366] Starting subtest: fence-restore-tiled2untiled
[537.400989] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[537.481662] [081/133] (478s left) gem_mmap_gtt (basic)
[537.535819] Subtest basic: SKIP (0.000s)
[537.614929] [082/133] (478s left) syncobj_eventfd (timeline-wait-before-signal)
[537.678854] Starting subtest: timeline-wait-before-signal
[537.707209] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[537.764130] [083/133] (478s left) kms_atomic (test-only)
[537.849962] Starting subtest: test-only
[537.898754] Starting dynamic subtest: pipe-A-eDP-1
[540.455005] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.554s)
[540.457185] Subtest test-only: SUCCESS (2.605s)
[541.223275] [084/133] (475s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[541.336403] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[541.340735] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[541.412603] [085/133] (474s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[541.469230] Starting subtest: invalid-single-wait-unsubmitted
[541.471187] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[541.554081] [086/133] (474s left) kms_invalid_mode (int-max-clock)
[541.651185] Starting subtest: int-max-clock
[541.653408] Starting dynamic subtest: pipe-A-eDP-1
[541.943434] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[541.953895] Starting dynamic subtest: pipe-B-eDP-1
[541.956132] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[541.965287] Starting dynamic subtest: pipe-C-eDP-1
[541.967208] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[541.976809] Starting dynamic subtest: pipe-D-eDP-1
[541.979086] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[541.981482] Subtest int-max-clock: SUCCESS (0.299s)
[542.753061] [087/133] (473s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[542.856820] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[549.744350] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.889s)
[549.851454] [088/133] (466s left) dmabuf_sync_file (export-before-signal)
[549.899267] Starting subtest: export-before-signal
[549.901710] Subtest export-before-signal: SUCCESS (0.001s)
[549.942814] [089/133] (466s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[550.056105] Starting subtest: cursor-vs-flip-toggle
[581.332433] Subtest cursor-vs-flip-toggle: SUCCESS (31.273s)
[582.125721] [090/133] (434s left) gem_exec_schedule (timeslicing)
[582.193363] Starting subtest: timeslicing
[582.195261] Starting dynamic subtest: rcs0
[582.204499] Dynamic subtest rcs0: SUCCESS (0.021s)
[582.214320] Starting dynamic subtest: bcs0
[582.226560] Dynamic subtest bcs0: SUCCESS (0.021s)
[582.241292] Starting dynamic subtest: vcs0
[582.247555] Dynamic subtest vcs0: SUCCESS (0.020s)
[582.257201] Starting dynamic subtest: vcs1
[582.268347] Dynamic subtest vcs1: SUCCESS (0.020s)
[582.278233] Starting dynamic subtest: vecs0
[582.289606] Dynamic subtest vecs0: SUCCESS (0.020s)
[582.302980] Starting dynamic subtest: ccs0
[582.313774] Dynamic subtest ccs0: SUCCESS (0.022s)
[582.315910] Subtest timeslicing: SUCCESS (0.131s)
[583.792651] [091/133] (432s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[583.900679] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[583.905256] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[583.948669] [092/133] (432s left) kms_addfb_basic (bad-pitch-32)
[584.002957] Starting subtest: bad-pitch-32
[584.005208] Subtest bad-pitch-32: SUCCESS (0.000s)
[584.122641] [093/133] (432s left) kms_cursor_crc (cursor-tearing-position-change)
[584.237296] Starting subtest: cursor-tearing-position-change
[584.239627] Starting dynamic subtest: pipe-A-eDP-1
[584.807745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[584.818279] Starting dynamic subtest: pipe-D-eDP-1
[586.084291] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.275s)
[586.086448] Subtest cursor-tearing-position-change: SUCCESS (1.845s)
[586.894918] [094/133] (429s left) perf (mi-rpc)
[586.968560] Starting subtest: mi-rpc
[586.973271] Subtest mi-rpc: SKIP (0.000s)
[587.019504] [095/133] (429s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[587.127664] Starting subtest: y-tiled-32bpp-rotate-270
[587.132065] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[587.215325] [096/133] (429s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[587.314899] Starting subtest: flip-vs-dpms-on-nop-interruptible
[587.320082] Starting dynamic subtest: A-eDP1
[589.212121] Dynamic subtest A-eDP1: SUCCESS (1.895s)
[589.225801] Starting dynamic subtest: B-eDP1
[591.042110] Dynamic subtest B-eDP1: SUCCESS (1.827s)
[591.057517] Starting dynamic subtest: C-eDP1
[592.857163] Dynamic subtest C-eDP1: SUCCESS (1.812s)
[592.867321] Starting dynamic subtest: D-eDP1
[594.706246] Dynamic subtest D-eDP1: SUCCESS (1.847s)
[594.711746] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.397s)
[595.866477] [097/133] (420s left) kms_frontbuffer_tracking (fbc-2p-rte)
[595.964451] Starting subtest: fbc-2p-rte
[595.969275] Subtest fbc-2p-rte: SKIP (0.000s)
[596.032953] [098/133] (420s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[596.120478] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[596.122727] Starting dynamic subtest: pipe-A-eDP-1
[596.178702] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[596.188262] Starting dynamic subtest: pipe-B-eDP-1
[596.244116] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[596.255037] Starting dynamic subtest: pipe-C-eDP-1
[596.311666] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[596.322430] Starting dynamic subtest: pipe-D-eDP-1
[596.380618] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[596.385040] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[598.423732] [099/133] (418s left) kms_content_protection (legacy)
[598.574800] Starting subtest: legacy
[598.579339] Subtest legacy: SKIP (0.000s)
[598.675713] [100/133] (418s left) gem_exec_store (pages)
[598.749672] Starting subtest: pages
[598.751962] Starting dynamic subtest: rcs0
[598.842012] Dynamic subtest rcs0: SUCCESS (0.093s)
[598.854280] Starting dynamic subtest: bcs0
[598.909191] Dynamic subtest bcs0: SUCCESS (0.066s)
[598.921126] Starting dynamic subtest: vcs0
[598.972712] Dynamic subtest vcs0: SUCCESS (0.063s)
[598.984409] Starting dynamic subtest: vcs1
[599.047480] Dynamic subtest vcs1: SUCCESS (0.074s)
[599.059052] Starting dynamic subtest: vecs0
[599.129454] Dynamic subtest vecs0: SUCCESS (0.081s)
[599.141344] Starting dynamic subtest: ccs0
[599.202556] Dynamic subtest ccs0: SUCCESS (0.071s)
[599.205117] Subtest pages: SUCCESS (0.455s)
[599.364183] [101/133] (417s left) perf_pmu (busy-no-semaphores)
[599.407721] Starting subtest: busy-no-semaphores
[599.410007] Starting dynamic subtest: rcs0
[599.953483] Dynamic subtest rcs0: SUCCESS (0.545s)
[599.965672] Starting dynamic subtest: bcs0
[600.504658] Dynamic subtest bcs0: SUCCESS (0.548s)
[600.517241] Starting dynamic subtest: vcs0
[601.054901] Dynamic subtest vcs0: SUCCESS (0.548s)
[601.066786] Starting dynamic subtest: vcs1
[602.334195] Dynamic subtest vcs1: SUCCESS (1.276s)
[602.346932] Starting dynamic subtest: vecs0
[604.320593] Dynamic subtest vecs0: SUCCESS (1.984s)
[604.332790] Starting dynamic subtest: ccs0
[606.305684] Dynamic subtest ccs0: SUCCESS (1.981s)
[606.308509] Subtest busy-no-semaphores: SUCCESS (6.900s)
[606.403295] [102/133] (410s left) vgem_basic (bad-pad)
[606.455803] Starting subtest: bad-pad
[606.457737] Subtest bad-pad: SUCCESS (0.000s)
[606.500064] [103/133] (410s left) gem_ctx_persistence (hang)
[606.548972] Starting subtest: hang
[606.553442] Subtest hang: SKIP (0.000s)
[606.628698] [104/133] (410s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[606.747967] Starting subtest: cursorA-vs-flipA-toggle
[617.874991] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.128s)
[618.652669] [105/133] (398s left) i915_hangman (error-state-basic)
[618.719052] Starting subtest: error-state-basic
[618.847638] Subtest error-state-basic: SUCCESS (0.131s)
[618.900810] [106/133] (398s left) core_auth (getclient-master-drop)
[618.953953] Starting subtest: getclient-master-drop
[618.964097] Subtest getclient-master-drop: SUCCESS (0.015s)
[619.025821] [107/133] (398s left) gem_exec_reloc (basic-write-gtt-noreloc)
[619.081590] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[619.154058] [108/133] (398s left) gem_softpin (overlap)
[619.215409] Starting subtest: overlap
[620.171903] Subtest overlap: SUCCESS (0.955s)
[620.287692] [109/133] (397s left) gem_pread (exhaustion)
[620.350120] Subtest exhaustion: SKIP (0.000s)
[620.417058] [110/133] (396s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[620.508793] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[620.511076] Starting dynamic subtest: pipe-A-eDP-1
[620.520266] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[620.531241] Starting dynamic subtest: pipe-B-eDP-1
[620.540278] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[620.550246] Starting dynamic subtest: pipe-C-eDP-1
[620.558905] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[620.568459] Starting dynamic subtest: pipe-D-eDP-1
[620.577245] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[620.581453] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[622.811723] [111/133] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[622.909909] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[622.913991] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[623.007359] [112/133] (394s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[623.102820] Starting subtest: psr2-overlay-plane-update-continuous-sf
[623.105102] Starting dynamic subtest: pipe-A-eDP-1
[624.229041] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.130s)
[624.241667] Starting dynamic subtest: pipe-B-eDP-1
[625.981898] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.754s)
[625.984189] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.887s)
[626.779353] [113/133] (390s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[626.867914] Starting subtest: async-flip-with-page-flip-events-linear
[627.251535] Starting dynamic subtest: pipe-A-eDP-1
[629.983123] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.731s)
[630.367676] Starting dynamic subtest: pipe-B-eDP-1
[633.115311] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[633.488999] Starting dynamic subtest: pipe-C-eDP-1
[636.238733] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.760s)
[636.610128] Starting dynamic subtest: pipe-D-eDP-1
[639.360885] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.758s)
[639.363263] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.497s)
[640.518605] [114/133] (377s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[640.618939] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[640.621220] Starting dynamic subtest: pipe-A-eDP-1
[640.645512] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[640.657349] Starting dynamic subtest: pipe-B-eDP-1
[640.680830] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[640.690193] Starting dynamic subtest: pipe-C-eDP-1
[640.713946] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[640.723151] Starting dynamic subtest: pipe-D-eDP-1
[640.746901] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[640.751177] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[642.878074] [115/133] (374s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[642.970818] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[642.973031] Starting dynamic subtest: pipe-A-eDP-1
[642.996240] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[643.007314] Starting dynamic subtest: pipe-B-eDP-1
[643.028750] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[643.038368] Starting dynamic subtest: pipe-C-eDP-1
[643.059812] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[643.071819] Starting dynamic subtest: pipe-D-eDP-1
[643.094006] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[643.098056] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[645.162578] [116/133] (372s left) gem_close_race (basic-threads)
[645.223211] Starting subtest: basic-threads
[646.605904] Subtest basic-threads: SUCCESS (1.383s)
[646.768260] [117/133] (370s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[647.029827] Starting subtest: cursor-rapid-movement-512x512
[647.034162] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[647.158308] [118/133] (370s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[647.252159] Starting subtest: 2x-absolute-wf_vblank-interruptible
[647.264127] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[647.320096] [119/133] (370s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[647.423662] Starting subtest: fbcpsr-shrfb-scaledprimary
[653.202042] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.782s)
[653.307326] [120/133] (364s left) kms_psr (fbc-pr-primary-page-flip)
[653.401056] Starting subtest: fbc-pr-primary-page-flip
[653.405274] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[653.454835] [121/133] (364s left) kms_atomic_interruptible (universal-setplane-cursor)
[653.545766] Starting subtest: universal-setplane-cursor
[653.548047] Starting dynamic subtest: pipe-A-eDP-1
[660.923134] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.377s)
[660.925403] Subtest universal-setplane-cursor: SUCCESS (7.378s)
[661.754111] [122/133] (356s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[661.842866] Starting subtest: plane-downscale-factor-0-5-with-rotation
[661.845160] Starting dynamic subtest: pipe-A
[661.863525] Dynamic subtest pipe-A: SKIP (0.017s)
[661.874146] Starting dynamic subtest: pipe-B
[661.895363] Dynamic subtest pipe-B: SKIP (0.032s)
[661.905589] Starting dynamic subtest: pipe-C
[661.929294] Dynamic subtest pipe-C: SKIP (0.032s)
[661.939304] Starting dynamic subtest: pipe-D
[661.961464] Dynamic subtest pipe-D: SKIP (0.032s)
[661.965150] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.116s)
[662.034751] [123/133] (355s left) gem_userptr_blits (vma-merge)
[662.106231] Starting subtest: vma-merge
[662.147859] Subtest vma-merge: SUCCESS (0.041s)
[662.238970] [124/133] (355s left) syncobj_wait (single-wait-for-submit-submitted)
[662.303339] Starting subtest: single-wait-for-submit-submitted
[662.409018] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[662.469846] [125/133] (355s left) kms_psr (fbc-psr-sprite-blt)
[662.562417] Starting subtest: fbc-psr-sprite-blt
[662.564646] Starting dynamic subtest: eDP-1
[662.568664] Dynamic subtest eDP-1: SKIP (0.000s)
[662.572569] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[662.614992] [126/133] (355s left) gem_exec_whisper (basic-queues-priority)
[662.679959] Starting subtest: basic-queues-priority
[686.966496] Subtest basic-queues-priority: SUCCESS (24.280s)
[687.131402] [127/133] (330s left) kms_cursor_crc (cursor-onscreen-32x10)
[687.287488] Starting subtest: cursor-onscreen-32x10
[687.342283] Subtest cursor-onscreen-32x10: SKIP (0.051s)
[687.598263] [128/133] (330s left) gem_mmap_gtt (fault-concurrent-y)
[687.660959] Subtest fault-concurrent-Y: SKIP (0.000s)
[687.744010] [129/133] (330s left) gem_basic (create-close)
[687.789603] Starting subtest: create-close
[687.794097] Subtest create-close: SUCCESS (0.000s)
[687.861820] [130/133] (330s left) kms_panel_fitting (atomic-fastset)
[687.953703] Starting subtest: atomic-fastset
[687.955671] Starting dynamic subtest: pipe-A-eDP-1
[688.097567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.146s)
[688.109541] Starting dynamic subtest: pipe-B-eDP-1
[689.333354] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s)
[689.348717] Starting dynamic subtest: pipe-C-eDP-1
[690.519503] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.184s)
[690.529921] Starting dynamic subtest: pipe-D-eDP-1
[691.670525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.149s)
[691.672846] Subtest atomic-fastset: SUCCESS (3.718s)
[692.886573] [131/133] (325s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[692.993940] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[700.703424] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.712s)
[700.785738] [132/133] (317s left) kms_psr (psr2-primary-mmap-cpu)
[700.882750] Starting subtest: psr2-primary-mmap-cpu
[700.884935] Starting dynamic subtest: eDP-1
[702.587470] Dynamic subtest eDP-1: SUCCESS (1.704s)
[702.589764] Subtest psr2-primary-mmap-cpu: SUCCESS (1.706s)
[703.448474] [133/133] (314s left) gem_ctx_shared (q-out-order)
[703.518005] Starting subtest: Q-out-order
[703.520302] Starting dynamic subtest: rcs0
[703.634984] Dynamic subtest rcs0: SUCCESS (0.115s)
[703.655332] Starting dynamic subtest: vcs0
[703.727489] Dynamic subtest vcs0: SUCCESS (0.092s)
[703.744708] Starting dynamic subtest: vcs1
[703.823713] Dynamic subtest vcs1: SUCCESS (0.096s)
[703.840728] Starting dynamic subtest: vecs0
[703.904119] Dynamic subtest vecs0: SUCCESS (0.079s)
[703.921962] Starting dynamic subtest: ccs0
[703.984456] Dynamic subtest ccs0: SUCCESS (0.079s)
[703.986886] Subtest Q-out-order: SUCCESS (0.467s)
[704.869420] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: gem_mmap_wc
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: gem_exec_basic
results: parsing output: 7/ for test: gem_flink_basic
results: parsing output: 8/ for test: kms_pm_backlight
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: kms_prop_blob
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_ctx_param
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_color_pipeline
results: parsing output: 17/ for test: kms_busy
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_chamelium_hpd
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_chamelium_edid
results: parsing output: 28/ for test: gem_blits
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gen3_render_linear_blits
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: kms_universal_plane
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: gem_exec_balancer
results: parsing output: 40/ for test: gem_wait
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: vgem_basic
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: kms_plane_multiple
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: i915_pm_rps
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: gem_mmap_wc
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_render_copy_redux
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: gen7_exec_parse
results: parsing output: 58/ for test: kms_dp_aux_dev
results: parsing output: 59/ for test: kms_pipe_stress
results: parsing output: 60/ for test: gem_exec_parallel
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: i915_drm_fdinfo
results: parsing output: 63/ for test: kms_hdr
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: api_intel_allocator
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_partial_pwrite_pread
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_dsc
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: i915_suspend
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: syncobj_eventfd
results: parsing output: 82/ for test: kms_atomic
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_invalid_mode
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: dmabuf_sync_file
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_content_protection
results: parsing output: 99/ for test: gem_exec_store
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: vgem_basic
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: i915_hangman
results: parsing output: 105/ for test: core_auth
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: gem_pread
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_async_flips
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_close_race
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_atomic_interruptible
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: gem_basic
results: parsing output: 129/ for test: kms_panel_fitting
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: gem_ctx_shared
Done.