[57.610256] Initializing watchdogs
[57.610302]   /dev/watchdog0
[57.623819] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.627853] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.630084] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.633300] [001/132] (960s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[57.778548] Starting subtest: 4-tiled-addfb-size-offset-overflow
[57.780508] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[57.896879] [002/132] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[57.990303] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[57.992501] Starting dynamic subtest: pipe-A-eDP-1
[58.109968] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[58.119225] Starting dynamic subtest: pipe-B-eDP-1
[59.288897] Dynamic subtest pipe-B-eDP-1: SKIP (1.177s)
[59.293370] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.302s)
[60.503225] [003/132] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[60.600533] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[60.604732] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[60.721412] [004/132] (957s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[60.949768] Starting subtest: cursor-rapid-movement-256x256
[60.954574] Starting dynamic subtest: pipe-A-eDP-1
[61.517418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[61.545943] Starting dynamic subtest: pipe-D-eDP-1
[62.769644] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[62.772068] Subtest cursor-rapid-movement-256x256: SUCCESS (1.818s)
[63.677293] [005/132] (954s left) syncobj_wait (wait-delayed-signal)
[63.742553] Starting subtest: wait-delayed-signal
[63.845361] Subtest wait-delayed-signal: SUCCESS (0.102s)
[63.928281] [006/132] (954s left) gem_ctx_param (root-set)
[63.979763] Starting subtest: root-set
[63.982284] Subtest root-set: SUCCESS (0.001s)
[64.097572] [007/132] (954s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[64.158072] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[64.162643] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[64.351383] [008/132] (954s left) i915_query (query-regions-garbage-items)
[64.411282] Starting subtest: query-regions-garbage-items
[64.413438] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[64.517643] [009/132] (953s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[64.605917] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[64.608249] Starting dynamic subtest: pipe-A-default-mode
[67.294738] Dynamic subtest pipe-A-default-mode: SUCCESS (2.688s)
[67.297096] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.689s)
[68.165189] [010/132] (950s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[68.262355] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[68.264721] Starting dynamic subtest: pipe-A
[68.323626] Dynamic subtest pipe-A: SUCCESS (0.064s)
[68.331626] Starting dynamic subtest: pipe-B
[69.494522] Dynamic subtest pipe-B: SUCCESS (1.170s)
[69.503604] Starting dynamic subtest: pipe-C
[70.609919] Dynamic subtest pipe-C: SUCCESS (1.114s)
[70.619108] Starting dynamic subtest: pipe-D
[71.736091] Dynamic subtest pipe-D: SUCCESS (1.126s)
[71.738488] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.476s)
[72.892630] [011/132] (945s left) kms_psr (fbc-psr2-primary-blt)
[72.981859] Starting subtest: fbc-psr2-primary-blt
[72.983775] Starting dynamic subtest: eDP-1
[72.987842] Dynamic subtest eDP-1: SKIP (0.000s)
[72.992069] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[73.072845] [012/132] (945s left) kms_pm_lpsp (kms-lpsp)
[74.178061] Starting subtest: kms-lpsp
[74.180322] Starting dynamic subtest: pipe-A-eDP-1
[74.324588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[74.610935] Subtest kms-lpsp: SUCCESS (0.432s)
[75.417877] [013/132] (943s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[75.482045] Starting subtest: multi-wait-available-unsubmitted-submitted
[75.484453] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[75.617350] [014/132] (942s left) kms_atomic_interruptible (universal-setplane-primary)
[75.721042] Starting subtest: universal-setplane-primary
[75.723395] Starting dynamic subtest: pipe-A-eDP-1
[83.163055] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.441s)
[83.165464] Subtest universal-setplane-primary: SUCCESS (7.442s)
[83.991219] [015/132] (934s left) api_intel_allocator (two-level-inception-interruptible)
[84.049823] Starting subtest: two-level-inception-interruptible
[89.461323] Subtest two-level-inception-interruptible: SUCCESS (5.412s)
[89.615149] [016/132] (929s left) kms_joiner (basic-force-ultra-joiner)
[89.737611] Starting subtest: basic-force-ultra-joiner
[89.741962] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[89.813217] [017/132] (928s left) kms_getfb (getfb-handle-zero)
[89.920978] Starting subtest: getfb-handle-zero
[89.923409] Subtest getfb-handle-zero: SUCCESS (0.000s)
[90.050697] [018/132] (928s left) kms_fbcon_fbt (psr)
[90.112883] Starting subtest: psr
[97.423694] Subtest psr: SUCCESS (7.308s)
[97.503838] [019/132] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[97.612046] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[97.616071] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[97.729204] [020/132] (921s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[98.124958] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[98.934914] [021/132] (919s left) gem_exec_whisper (basic-sync-all)
[99.002503] Starting subtest: basic-sync-all
[105.538973] Subtest basic-sync-all: SUCCESS (6.534s)
[105.733953] [022/132] (913s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[105.851208] Starting subtest: x-tiled-32bpp-rotate-90
[105.869874] Subtest x-tiled-32bpp-rotate-90: SKIP (0.018s)
[106.029018] [023/132] (912s left) kms_psr (fbc-pr-basic)
[106.119091] Starting subtest: fbc-pr-basic
[106.123239] Subtest fbc-pr-basic: SKIP (0.000s)
[106.198238] [024/132] (912s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[106.306413] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[106.310746] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[106.416577] [025/132] (912s left) perf_pmu (init-wait)
[106.451938] Starting subtest: init-wait
[106.454230] Starting dynamic subtest: rcs0
[106.456440] Dynamic subtest rcs0: SUCCESS (0.002s)
[106.465162] Starting dynamic subtest: bcs0
[106.467250] Dynamic subtest bcs0: SUCCESS (0.000s)
[106.474113] Starting dynamic subtest: vcs0
[106.476236] Dynamic subtest vcs0: SUCCESS (0.000s)
[106.483308] Starting dynamic subtest: vcs1
[106.485167] Dynamic subtest vcs1: SUCCESS (0.000s)
[106.493466] Starting dynamic subtest: vecs0
[106.495473] Dynamic subtest vecs0: SUCCESS (0.000s)
[106.502321] Starting dynamic subtest: ccs0
[106.504485] Dynamic subtest ccs0: SUCCESS (0.000s)
[106.506667] Subtest init-wait: SUCCESS (0.006s)
[106.567824] [026/132] (912s left) kms_legacy_colorkey (invalid-plane)
[106.662764] Starting subtest: invalid-plane
[106.664819] Starting dynamic subtest: zero-id
[106.666810] Dynamic subtest zero-id: SUCCESS (0.000s)
[106.674680] Starting dynamic subtest: outrange-id
[106.676282] Dynamic subtest outrange-id: SUCCESS (0.000s)
[106.678198] Subtest invalid-plane: SUCCESS (0.001s)
[106.745985] [027/132] (912s left) kms_vblank (wait-busy-hang)
[106.835210] Starting subtest: wait-busy-hang
[106.837075] Starting dynamic subtest: pipe-A-eDP-1
[133.657063] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.818s)
[133.669102] Starting dynamic subtest: pipe-D-eDP-1
[148.697897] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.039s)
[148.700215] Subtest wait-busy-hang: SUCCESS (41.862s)
[149.529093] [028/132] (869s left) syncobj_eventfd (binary-wait)
[149.579815] Starting subtest: binary-wait
[149.588410] Subtest binary-wait: SUCCESS (0.010s)
[149.669918] [029/132] (869s left) gem_mmap_gtt (basic-read-write)
[149.730279] Subtest basic-read-write: SKIP (0.000s)
[149.796813] [030/132] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[149.929875] Starting subtest: basic-busy-flip-before-cursor-varying-size
[149.934826] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[150.093241] [031/132] (869s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[150.199527] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[154.633030] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.437s)
[155.821157] [032/132] (863s left) gem_exec_fence (syncobj-repeat)
[156.283595] Starting subtest: syncobj-repeat
[156.455686] Subtest syncobj-repeat: SUCCESS (0.170s)
[157.956147] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[157.959424] [033/132] (861s left) gem_mmap_gtt (basic-wc)
[158.027161] Subtest basic-wc: SKIP (0.000s)
[158.100242] [034/132] (861s left) kms_atomic (test-only)
[158.196604] Starting subtest: test-only
[158.246732] Starting dynamic subtest: pipe-A-eDP-1
[160.718420] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.469s)
[160.720354] Subtest test-only: SUCCESS (2.522s)
[161.601393] [035/132] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[161.710506] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[161.714564] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[161.858930] [036/132] (857s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[161.974363] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[163.373127] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.398s)
[164.189354] [037/132] (855s left) kms_vrr (seamless-rr-switch-drrs)
[164.281059] Starting subtest: seamless-rr-switch-drrs
[164.287450] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[164.369065] [038/132] (855s left) kms_content_protection (content-type-change)
[164.499820] Starting subtest: content-type-change
[164.503909] Subtest content-type-change: SKIP (0.000s)
[164.659615] [039/132] (854s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[164.764025] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[164.768134] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[164.847665] [040/132] (854s left) i915_pm_rpm (system-suspend-devices)
[167.084985] Starting subtest: system-suspend-devices
[174.902107] Subtest system-suspend-devices: SUCCESS (7.820s)
[175.300445] [041/132] (844s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[175.423432] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[176.380311] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.956s)
[176.561054] [042/132] (843s left) gem_mmap_gtt (basic-write-read-distinct)
[176.621540] Subtest basic-write-read-distinct: SKIP (0.000s)
[176.686065] [043/132] (843s left) gem_ctx_shared (q-in-order)
[176.761061] Starting subtest: Q-in-order
[176.762687] Starting dynamic subtest: rcs0
[176.855974] Dynamic subtest rcs0: SUCCESS (0.096s)
[176.871159] Starting dynamic subtest: vcs0
[176.932812] Dynamic subtest vcs0: SUCCESS (0.076s)
[176.948430] Starting dynamic subtest: vcs1
[177.005689] Dynamic subtest vcs1: SUCCESS (0.072s)
[177.020455] Starting dynamic subtest: vecs0
[177.073673] Dynamic subtest vecs0: SUCCESS (0.068s)
[177.089586] Starting dynamic subtest: ccs0
[177.142517] Dynamic subtest ccs0: SUCCESS (0.068s)
[177.144954] Subtest Q-in-order: SUCCESS (0.383s)
[179.008593] [044/132] (840s left) syncobj_timeline (wait-all-complex)
[179.073384] Starting subtest: wait-all-complex
[179.285233] Subtest wait-all-complex: SUCCESS (0.212s)
[179.375195] [045/132] (840s left) kms_async_flips (alternate-sync-async-flip-atomic)
[179.468278] Starting subtest: alternate-sync-async-flip-atomic
[179.852315] Starting dynamic subtest: pipe-A-eDP-1
[182.674146] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.823s)
[183.049408] Starting dynamic subtest: pipe-B-eDP-1
[185.800605] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[186.178909] Starting dynamic subtest: pipe-C-eDP-1
[188.929063] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s)
[189.299620] Starting dynamic subtest: pipe-D-eDP-1
[192.063090] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[192.065030] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.596s)
[193.254641] [046/132] (826s left) gem_ctx_create (basic-files)
[193.323392] Starting subtest: basic-files
[195.330498] Subtest basic-files: SUCCESS (2.007s)
[196.944030] [047/132] (822s left) gem_tiling_max_stride
[197.066887] [048/132] (822s left) i915_drm_fdinfo (virtual-idle)
[197.105336] Starting subtest: virtual-idle
[200.189715] Subtest virtual-idle: SUCCESS (3.084s)
[200.263388] [049/132] (819s left) kms_chamelium_edid (dp-edid-read)
[200.647820] Subtest dp-edid-read: SKIP (0.000s)
[201.456008] [050/132] (818s left) gem_ctx_persistence (process)
[201.510403] Starting subtest: process
[201.716966] Subtest process: SUCCESS (0.206s)
[201.815133] [051/132] (818s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[201.917144] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[201.919479] Starting dynamic subtest: pipe-A-eDP-1
[201.928743] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[201.942101] Starting dynamic subtest: pipe-B-eDP-1
[201.950996] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[201.959040] Starting dynamic subtest: pipe-C-eDP-1
[201.967515] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[201.975335] Starting dynamic subtest: pipe-D-eDP-1
[201.983822] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[201.987972] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[204.171578] [052/132] (815s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[204.274896] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[204.277233] Starting dynamic subtest: A-eDP1
[207.891367] Dynamic subtest A-eDP1: SUCCESS (3.612s)
[207.901941] Starting dynamic subtest: B-eDP1
[211.084416] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[211.093370] Starting dynamic subtest: C-eDP1
[214.180948] Dynamic subtest C-eDP1: SUCCESS (3.096s)
[214.190688] Starting dynamic subtest: D-eDP1
[217.284544] Dynamic subtest D-eDP1: SUCCESS (3.101s)
[217.286797] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.010s)
[218.096411] [053/132] (802s left) core_setmaster (master-drop-set-shared-fd)
[218.177890] Starting subtest: master-drop-set-shared-fd
[218.199842] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[218.239455] [054/132] (801s left) api_intel_bb (simple-bb)
[218.298291] Starting subtest: simple-bb
[218.302079] Subtest simple-bb: SUCCESS (0.006s)
[218.457966] [055/132] (801s left) gem_exec_suspend (basic-s3-devices)
[218.524781] Starting subtest: basic-S3-devices
[218.527207] Starting dynamic subtest: smem
[229.909464] Dynamic subtest smem: SUCCESS (11.382s)
[229.912651] Subtest basic-S3-devices: SUCCESS (11.384s)
[230.110158] [056/132] (790s left) gem_exec_reloc (basic-write-gtt-active)
[230.192220] Subtest basic-write-gtt-active: SKIP (0.000s)
[230.289101] [057/132] (790s left) syncobj_wait (single-wait-all-submitted)
[230.354617] Starting subtest: single-wait-all-submitted
[230.456057] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[230.548752] [058/132] (789s left) gem_exec_schedule (submit-late-slice)
[230.618739] Starting subtest: submit-late-slice
[230.621082] Starting dynamic subtest: rcs0
[230.667782] Dynamic subtest rcs0: SUCCESS (0.056s)
[230.677779] Starting dynamic subtest: bcs0
[230.717799] Dynamic subtest bcs0: SUCCESS (0.048s)
[230.729633] Starting dynamic subtest: vcs0
[230.762865] Dynamic subtest vcs0: SUCCESS (0.045s)
[230.773231] Starting dynamic subtest: vcs1
[230.812213] Dynamic subtest vcs1: SUCCESS (0.048s)
[230.825504] Starting dynamic subtest: vecs0
[230.867666] Dynamic subtest vecs0: SUCCESS (0.054s)
[230.878507] Starting dynamic subtest: ccs0
[230.922066] Dynamic subtest ccs0: SUCCESS (0.054s)
[230.925054] Subtest submit-late-slice: SUCCESS (0.311s)
[232.018214] [059/132] (788s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[232.132266] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[232.144422] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[232.269413] [060/132] (788s left) gem_pxp (create-valid-protected-context)
[232.388044] Starting subtest: create-valid-protected-context
[232.390468] Subtest create-valid-protected-context: SUCCESS (0.002s)
[232.519555] [061/132] (787s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[232.621880] Starting subtest: fbcpsr-tiling-linear
[239.223710] Subtest fbcpsr-tiling-linear: SUCCESS (6.605s)
[239.396126] [062/132] (781s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[239.500508] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[239.502764] Starting dynamic subtest: pipe-A-eDP-1
[239.573161] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[239.583213] Starting dynamic subtest: pipe-B-eDP-1
[240.675435] Dynamic subtest pipe-B-eDP-1: SKIP (1.099s)
[240.679939] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.178s)
[241.967949] [063/132] (778s left) gem_ctx_persistence (engines-mixed-process)
[242.035475] Starting subtest: engines-mixed-process
[242.037826] Starting dynamic subtest: rcs0
[243.934226] Dynamic subtest rcs0: SUCCESS (1.899s)
[243.945100] Starting dynamic subtest: bcs0
[245.911961] Dynamic subtest bcs0: SUCCESS (1.977s)
[245.922981] Starting dynamic subtest: vcs0
[247.898806] Dynamic subtest vcs0: SUCCESS (1.986s)
[247.910338] Starting dynamic subtest: vcs1
[249.966907] Dynamic subtest vcs1: SUCCESS (2.067s)
[249.978476] Starting dynamic subtest: vecs0
[251.931799] Dynamic subtest vecs0: SUCCESS (1.963s)
[251.943206] Starting dynamic subtest: ccs0
[253.938059] Dynamic subtest ccs0: SUCCESS (2.004s)
[253.941259] Subtest engines-mixed-process: SUCCESS (11.904s)
[254.028732] [064/132] (766s left) gem_ccs (block-copy-compressed)
[254.078240] Starting subtest: block-copy-compressed
[254.082695] Subtest block-copy-compressed: SKIP (0.000s)
[254.200012] [065/132] (766s left) gem_eio (unwedge-stress)
[254.444349] Starting subtest: unwedge-stress
[254.447367] Starting dynamic subtest: render
[259.511570] Dynamic subtest render: SUCCESS (5.064s)
[259.528776] Starting dynamic subtest: bsd1
[277.423668] Dynamic subtest bsd1: SUCCESS (17.910s)
[277.434308] Starting dynamic subtest: bsd2
[295.492979] Dynamic subtest bsd2: SUCCESS (18.068s)
[295.509708] Starting dynamic subtest: blt
[295.513863] Dynamic subtest blt: SKIP (0.000s)
[295.522764] Starting dynamic subtest: vebox
[313.401690] Dynamic subtest vebox: SUCCESS (17.906s)
[313.404066] Subtest unwedge-stress: SUCCESS (58.953s)
[314.950085] [066/132] (705s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[315.000328] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[315.063883] [067/132] (705s left) kms_flip (busy-flip)
[315.145986] Starting subtest: busy-flip
[315.148247] Starting dynamic subtest: A-eDP1
[316.870829] Dynamic subtest A-eDP1: SUCCESS (1.724s)
[316.888804] Starting dynamic subtest: B-eDP1
[318.605465] Dynamic subtest B-eDP1: SUCCESS (1.734s)
[318.616769] Starting dynamic subtest: C-eDP1
[320.237409] Dynamic subtest C-eDP1: SUCCESS (1.629s)
[320.248120] Starting dynamic subtest: D-eDP1
[321.878772] Dynamic subtest D-eDP1: SUCCESS (1.640s)
[321.884844] Subtest busy-flip: SUCCESS (6.739s)
[323.164147] [068/132] (697s left) i915_drm_fdinfo (virtual-busy-hang)
[323.201791] Starting subtest: virtual-busy-hang
[323.206079] Subtest virtual-busy-hang: SKIP (0.000s)
[323.287017] [069/132] (697s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[323.383883] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[323.388103] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[323.467203] [070/132] (697s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[323.557215] Starting subtest: invalidate-primary-flip-overlay
[334.312738] Subtest invalidate-primary-flip-overlay: SUCCESS (10.758s)
[334.455309] [071/132] (686s left) kms_pm_rpm (system-suspend-idle)
[336.078200] Starting subtest: system-suspend-idle
[355.460316] Subtest system-suspend-idle: SUCCESS (4.486s)
[355.847376] [072/132] (665s left) gem_ccs (suspend-resume)
[355.912924] Starting subtest: suspend-resume
[355.917610] Subtest suspend-resume: SKIP (0.000s)
[356.044771] [073/132] (664s left) kms_big_fb (linear-16bpp-rotate-180)
[356.146035] Starting subtest: linear-16bpp-rotate-180
[357.671327] Subtest linear-16bpp-rotate-180: SUCCESS (1.523s)
[357.846747] [074/132] (663s left) kms_plane_lowres (tiling-x)
[357.944482] Starting subtest: tiling-x
[357.946221] Starting dynamic subtest: pipe-A-eDP-1
[357.949898] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[358.238631] Starting dynamic subtest: pipe-B-eDP-1
[358.243041] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[358.251903] Starting dynamic subtest: pipe-C-eDP-1
[358.256343] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[358.265204] Starting dynamic subtest: pipe-D-eDP-1
[358.269390] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[358.273666] Subtest tiling-x: SKIP (0.292s)
[359.070691] [075/132] (661s left) gem_close_race (basic-threads)
[359.147410] Starting subtest: basic-threads
[360.547156] Subtest basic-threads: SUCCESS (1.398s)
[360.740329] [076/132] (660s left) kms_getfb (getfb-handle-protection)
[360.831316] Starting subtest: getfb-handle-protection
[360.855712] Subtest getfb-handle-protection: SUCCESS (0.025s)
[361.009477] [077/132] (660s left) kms_feature_discovery (display)
[361.109366] Starting subtest: display
[361.111563] Subtest display: SUCCESS (0.000s)
[361.192180] [078/132] (659s left) kms_chamelium_color (ctm-0-25)
[361.298728] Subtest ctm-0-25: SKIP (0.000s)
[361.343019] [079/132] (659s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[361.443698] Starting subtest: y-tiled-8bpp-rotate-180
[361.447971] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[361.561631] [080/132] (659s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[361.684919] Starting subtest: flip-vs-cursor-crc-atomic
[362.318218] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.632s)
[363.191612] [081/132] (658s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[363.300729] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[370.638834] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.336s)
[370.803583] [082/132] (650s left) kms_frontbuffer_tracking (psr-1p-rte)
[370.905123] Starting subtest: psr-1p-rte
[376.295620] Subtest psr-1p-rte: SUCCESS (5.392s)
[376.465481] [083/132] (644s left) gem_wait (write-wait)
[376.537069] Starting subtest: write-wait
[376.539499] Starting dynamic subtest: all-engines
[377.706337] Dynamic subtest all-engines: SUCCESS (1.168s)
[377.723369] Starting dynamic subtest: rcs0
[378.765034] Dynamic subtest rcs0: SUCCESS (1.056s)
[378.781659] Starting dynamic subtest: bcs0
[379.826025] Dynamic subtest bcs0: SUCCESS (1.058s)
[379.843267] Starting dynamic subtest: vcs0
[380.880798] Dynamic subtest vcs0: SUCCESS (1.053s)
[380.897002] Starting dynamic subtest: vcs1
[381.934480] Dynamic subtest vcs1: SUCCESS (1.051s)
[381.951532] Starting dynamic subtest: vecs0
[382.989608] Dynamic subtest vecs0: SUCCESS (1.052s)
[383.006428] Starting dynamic subtest: ccs0
[384.045714] Dynamic subtest ccs0: SUCCESS (1.054s)
[384.048221] Subtest write-wait: SUCCESS (7.508s)
[384.258312] [084/132] (637s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[384.360292] Starting subtest: bad-pixel-format-y-tiled-ccs
[384.362495] Starting dynamic subtest: pipe-A-eDP-1
[384.385317] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[384.396838] Starting dynamic subtest: pipe-B-eDP-1
[384.419547] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[384.430676] Starting dynamic subtest: pipe-C-eDP-1
[384.452369] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[384.462919] Starting dynamic subtest: pipe-D-eDP-1
[384.484441] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[384.488437] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.006s)
[386.596189] [085/132] (634s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[386.707465] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[386.711402] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[386.829435] [086/132] (634s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[386.923347] Starting subtest: fbc-shrfb-scaledprimary
[389.916024] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.995s)
[391.091406] [087/132] (630s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[391.182530] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[391.184850] Starting dynamic subtest: pipe-A-eDP-1
[391.208700] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[391.219734] Starting dynamic subtest: pipe-B-eDP-1
[391.241646] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[391.251376] Starting dynamic subtest: pipe-C-eDP-1
[391.273732] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[391.284386] Starting dynamic subtest: pipe-D-eDP-1
[391.306722] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[391.310825] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[393.358031] [088/132] (628s left) gen9_exec_parse (bb-large)
[393.421396] Subtest bb-large: SKIP (0.000s)
[393.495388] [089/132] (628s left) perf (i915-ref-count)
[393.579691] Starting subtest: i915-ref-count
[393.639654] Subtest i915-ref-count: SUCCESS (0.058s)
[393.693562] [090/132] (627s left) sw_sync (alloc_fence_invalid_timeline)
[393.723918] Starting subtest: alloc_fence_invalid_timeline
[393.725851] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[393.802964] [091/132] (627s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[393.909092] Starting subtest: psr-modesetfrombusy
[400.052655] Subtest psr-modesetfrombusy: SUCCESS (6.148s)
[400.200631] [092/132] (621s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[400.303134] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[400.306676] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[400.451233] [093/132] (621s left) gem_softpin (allocator-basic)
[400.510522] Starting subtest: allocator-basic
[400.579923] Subtest allocator-basic: SUCCESS (0.069s)
[400.703984] [094/132] (621s left) gem_render_copy (linear-to-vebox-y-tiled)
[400.773515] Starting subtest: linear-to-vebox-y-tiled
[400.777332] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[400.968880] [095/132] (620s left) gem_mmap_gtt (hang)
[401.030700] Subtest hang: SKIP (0.000s)
[401.097315] [096/132] (620s left) gem_exec_schedule (out-order)
[401.158206] Starting subtest: out-order
[401.160264] Starting dynamic subtest: rcs0
[401.246544] Dynamic subtest rcs0: SUCCESS (0.095s)
[401.258879] Starting dynamic subtest: vcs0
[401.325893] Dynamic subtest vcs0: SUCCESS (0.079s)
[401.334724] Starting dynamic subtest: vcs1
[401.402652] Dynamic subtest vcs1: SUCCESS (0.076s)
[401.415999] Starting dynamic subtest: vecs0
[401.482563] Dynamic subtest vecs0: SUCCESS (0.079s)
[401.491726] Starting dynamic subtest: ccs0
[401.568576] Dynamic subtest ccs0: SUCCESS (0.083s)
[401.571505] Subtest out-order: SUCCESS (0.418s)
[402.938634] [097/132] (619s left) gem_exec_reloc (basic-scanout)
[403.005849] Subtest basic-scanout: SKIP (0.000s)
[403.089551] [098/132] (618s left) kms_psr (fbc-psr-primary-render)
[403.176298] Starting subtest: fbc-psr-primary-render
[403.178670] Starting dynamic subtest: eDP-1
[403.182874] Dynamic subtest eDP-1: SKIP (0.000s)
[403.187067] Subtest fbc-psr-primary-render: SKIP (0.001s)
[403.267844] [099/132] (618s left) prime_mmap (test_correct_cpu_write)
[403.326843] Starting subtest: test_correct_cpu_write
[403.328824] Starting dynamic subtest: test_correct_cpu_write-smem
[403.330825] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[403.332816] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[403.454144] [100/132] (618s left) syncobj_timeline (invalid-signal-zero-handles)
[403.506410] Starting subtest: invalid-signal-zero-handles
[403.508607] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[403.631464] [101/132] (618s left) kms_cursor_legacy (torture-bo)
[403.752621] Starting subtest: torture-bo
[403.754450] Starting dynamic subtest: pipe-A
[409.671210] Dynamic subtest pipe-A: SUCCESS (5.914s)
[409.688577] Starting dynamic subtest: pipe-B
[416.552813] Dynamic subtest pipe-B: SUCCESS (6.879s)
[416.563936] Starting dynamic subtest: pipe-C
[423.122465] Dynamic subtest pipe-C: SUCCESS (6.566s)
[423.132673] Starting dynamic subtest: pipe-D
[429.728914] Dynamic subtest pipe-D: SUCCESS (6.604s)
[429.741009] Starting dynamic subtest: all-pipes
[436.080154] Dynamic subtest all-pipes: SUCCESS (6.350s)
[436.082328] Subtest torture-bo: SUCCESS (32.323s)
[436.246509] [102/132] (585s left) kms_cursor_crc (cursor-onscreen-32x10)
[436.433300] Starting subtest: cursor-onscreen-32x10
[436.490963] Subtest cursor-onscreen-32x10: SKIP (0.053s)
[436.796660] [103/132] (585s left) gem_mmap_offset (partial-mmap)
[436.841405] Starting subtest: partial-mmap
[436.843735] Starting dynamic subtest: smem0
[436.845951] Dynamic subtest smem0: SUCCESS (0.003s)
[436.847819] Subtest partial-mmap: SUCCESS (0.004s)
[436.993995] [104/132] (585s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[437.099192] Starting subtest: plane-lut1d-ctm3x4-lut1d
[437.113757] Starting dynamic subtest: pipe-A-eDP-1
[437.752344] Dynamic subtest pipe-A-eDP-1: FAIL (0.311s)
[438.503981] Starting dynamic subtest: pipe-B-eDP-1
[439.317299] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s)
[439.830083] Starting dynamic subtest: pipe-C-eDP-1
[440.646107] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[441.159388] Starting dynamic subtest: pipe-D-eDP-1
[442.018332] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[442.020368] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.620s)
[442.555634] [105/132] (579s left) gem_userptr_blits (unsync-overlap)
[442.629766] Subtest unsync-overlap: SKIP (0.000s)
[442.781347] [106/132] (579s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[442.871463] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[442.875689] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[442.997012] [107/132] (579s left) kms_selftest (drm_damage_helper)
[443.040212] Starting subtest: drm_damage_helper
[443.084283] Starting dynamic subtest: drm_test_damage_iter_no_damage
[443.219850] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.136s)
[443.228827] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[443.364335] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.141s)
[443.380018] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[443.501811] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.137s)
[443.512111] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[443.656544] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.153s)
[443.671178] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[443.786011] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.129s)
[443.801317] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[443.909074] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.123s)
[443.918905] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[444.054892] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.143s)
[444.065647] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[444.193553] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.139s)
[444.204290] Starting dynamic subtest: drm_test_damage_iter_single_damage
[444.332390] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.138s)
[444.343381] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[444.443567] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.111s)
[444.454142] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[444.582468] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.137s)
[444.592704] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[444.714317] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.132s)
[444.725022] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[444.803402] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.088s)
[444.814134] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[444.934445] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.130s)
[444.944928] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[445.067299] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.131s)
[445.077514] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[445.171426] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.104s)
[445.181590] Starting dynamic subtest: drm_test_damage_iter_damage
[445.298216] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.125s)
[445.307916] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[445.393857] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.097s)
[445.402406] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[445.518525] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.122s)
[445.528787] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[445.649568] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.131s)
[445.658084] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[445.775570] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.125s)
[445.777497] Subtest drm_damage_helper: SUCCESS (2.735s)
[445.996615] [108/132] (576s left) gem_exec_capture (capture-recoverable)
[446.063993] Starting subtest: capture-recoverable
[446.066308] Subtest capture-recoverable: SUCCESS (0.005s)
[446.210705] [109/132] (576s left) gem_tiled_swapping (non-threaded)
[446.270195] Subtest non-threaded: SKIP (0.000s)
[446.341606] [110/132] (576s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[446.442133] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[446.443967] Starting dynamic subtest: pipe-A-eDP-1
[447.291709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.842s)
[447.302157] Starting dynamic subtest: pipe-B-eDP-1
[448.890667] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.596s)
[448.901258] Starting dynamic subtest: pipe-C-eDP-1
[450.400284] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.509s)
[450.411128] Starting dynamic subtest: pipe-D-eDP-1
[451.882157] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.480s)
[451.884758] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.432s)
[453.091471] [111/132] (569s left) gem_exec_balancer (full-pulse)
[453.146719] Starting subtest: full-pulse
[457.696327] Subtest full-pulse: SUCCESS (4.550s)
[457.985318] [112/132] (564s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[458.083717] Starting subtest: fbc-rgb565-draw-render
[462.238004] Subtest fbc-rgb565-draw-render: SUCCESS (4.158s)
[463.390076] [113/132] (559s left) kms_flip (flip-vs-panning-vs-hang)
[463.490707] Starting subtest: flip-vs-panning-vs-hang
[463.492995] Starting dynamic subtest: A-eDP1
[514.278402] Dynamic subtest A-eDP1: SUCCESS (50.788s)
[514.290125] Starting dynamic subtest: D-eDP1
[554.284564] Dynamic subtest D-eDP1: SUCCESS (40.000s)
[554.286949] Subtest flip-vs-panning-vs-hang: SUCCESS (90.792s)
[555.481760] [114/132] (467s left) kms_addfb_basic (clobberred-modifier)
[555.542662] Starting subtest: clobberred-modifier
[555.547201] Subtest clobberred-modifier: SKIP (0.000s)
[555.703094] [115/132] (466s left) gem_lmem_swapping (smem-oom)
[555.743537] Subtest smem-oom: SKIP (0.000s)
[555.785646] [116/132] (466s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[555.880169] Starting subtest: coverage-vs-premult-vs-constant
[556.168344] Starting dynamic subtest: pipe-A-eDP-1
[556.735621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[556.749659] Starting dynamic subtest: pipe-D-eDP-1
[558.076944] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[558.079449] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.198s)
[558.934238] [117/132] (463s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[559.037961] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[559.041998] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[559.159374] [118/132] (463s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[559.221773] Starting subtest: etime-single-wait-for-submit-submitted
[559.325298] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.103s)
[559.413445] [119/132] (463s left) gem_softpin (noreloc)
[559.467168] Starting subtest: noreloc
[564.851508] Subtest noreloc: SUCCESS (5.382s)
[565.008042] [120/132] (457s left) gem_render_tiled_blits (basic)
[565.066184] Subtest basic: SKIP (0.000s)
[565.146387] [121/132] (457s left) kms_psr (pr-suspend)
[565.251079] Starting subtest: pr-suspend
[565.255534] Subtest pr-suspend: SKIP (0.000s)
[565.333940] [122/132] (457s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[565.387771] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[565.493270] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[565.591335] [123/132] (457s left) kms_psr (psr-cursor-blt)
[565.701296] Starting subtest: psr-cursor-blt
[565.703567] Starting dynamic subtest: eDP-1
[567.411043] Dynamic subtest eDP-1: SUCCESS (1.710s)
[567.413419] Subtest psr-cursor-blt: SUCCESS (1.711s)
[568.302470] [124/132] (454s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[568.414792] Starting subtest: fbc-rgb565-draw-mmap-gtt
[568.419198] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[568.545285] [125/132] (454s left) gem_exec_params (sol-reset-not-gen7)
[568.611821] Starting subtest: sol-reset-not-gen7
[568.613715] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[568.767363] [126/132] (454s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[568.881113] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[568.885486] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[569.015040] [127/132] (454s left) kms_plane (planar-pixel-format-settings)
[569.108613] Starting subtest: planar-pixel-format-settings
[569.170555] Subtest planar-pixel-format-settings: SUCCESS (0.062s)
[569.304425] [128/132] (453s left) gem_exec_whisper (basic-fds-priority-all)
[569.365376] Starting subtest: basic-fds-priority-all
[591.409135] Subtest basic-fds-priority-all: SUCCESS (22.040s)
[591.607057] [129/132] (431s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[591.674723] Starting subtest: invalid-single-wait-all-unsubmitted
[591.676968] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[591.799599] [130/132] (431s left) kms_flip (2x-flip-vs-expired-vblank)
[591.899715] Starting subtest: 2x-flip-vs-expired-vblank
[591.910570] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[592.024993] [131/132] (431s left) gem_exec_flush (basic-batch-kernel-default-uc)
[592.095837] Starting subtest: basic-batch-kernel-default-uc
[599.453905] Subtest basic-batch-kernel-default-uc: SUCCESS (7.362s)
[599.648441] [132/132] (423s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[599.748848] Starting subtest: fbcpsr-modesetfrombusy
[605.975319] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.231s)
[606.135172] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: i915_query
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_pm_lpsp
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_atomic_interruptible
results: parsing output: 14/ for test: api_intel_allocator
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: kms_fbcon_fbt
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_legacy_colorkey
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: syncobj_eventfd
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_atomic
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_vrr
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: i915_pm_rpm
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: gem_ctx_shared
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: gem_ctx_create
results: parsing output: 46/ for test: gem_tiling_max_stride
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: kms_chamelium_edid
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: core_setmaster
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: gem_exec_suspend
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: gem_ccs
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_pipe_b_c_ivb
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_psr_stress_test
results: parsing output: 70/ for test: kms_pm_rpm
results: parsing output: 71/ for test: gem_ccs
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_plane_lowres
results: parsing output: 74/ for test: gem_close_race
results: parsing output: 75/ for test: kms_getfb
results: parsing output: 76/ for test: kms_feature_discovery
results: parsing output: 77/ for test: kms_chamelium_color
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_mmap_offset
results: parsing output: 103/ for test: kms_color_pipeline
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_selftest
results: parsing output: 107/ for test: gem_exec_capture
results: parsing output: 108/ for test: gem_tiled_swapping
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: gem_lmem_swapping
results: parsing output: 115/ for test: kms_plane_alpha_blend
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_softpin
results: parsing output: 119/ for test: gem_render_tiled_blits
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: gem_exec_flush
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.