[60.038272] Initializing watchdogs
[60.038323]   /dev/watchdog0
[60.054371] [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]
[60.058949] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.061417] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.063682] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[60.164247] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[60.166078] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[60.263799] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[60.363287] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[60.364942] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[60.442857] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[60.550857] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[61.223398] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[61.381538] [004/133] (959s left) gen7_exec_parse (basic-offset)
[61.449621] Subtest basic-offset: SKIP (0.000s)
[61.505483] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[61.608712] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[65.997605] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.374s)
[67.179354] [006/133] (953s left) tools_test (tools_test)
[67.246901] Starting subtest: tools_test
[67.341227] Subtest tools_test: SUCCESS (0.100s)
[67.428522] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[67.537528] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[67.539729] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[68.661541] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[68.743952] Starting subtest: modeset-vs-vblank-race
[68.745065] Starting dynamic subtest: A-eDP1
[73.410729] Dynamic subtest A-eDP1: SUCCESS (4.659s)
[73.420311] Starting dynamic subtest: B-eDP1
[78.148036] Dynamic subtest B-eDP1: SUCCESS (4.732s)
[78.159351] Starting dynamic subtest: C-eDP1
[82.851095] Dynamic subtest C-eDP1: SUCCESS (4.698s)
[82.859257] Starting dynamic subtest: D-eDP1
[87.397354] Dynamic subtest D-eDP1: SUCCESS (4.543s)
[87.399878] Subtest modeset-vs-vblank-race: SUCCESS (18.640s)
[88.550850] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[90.070186] Starting subtest: reg-read-ioctl
[92.363360] Subtest reg-read-ioctl: SUCCESS (2.294s)
[92.754323] [010/133] (928s left) gem_exec_balancer (hang)
[93.034684] Starting subtest: hang
[94.919510] Subtest hang: SUCCESS (1.885s)
[95.032879] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[95.121351] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[95.123093] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[95.184962] [012/133] (925s left) perf_pmu (faulting-read)
[95.221744] Starting subtest: faulting-read
[95.222763] Starting dynamic subtest: wb
[95.223716] Dynamic subtest wb: SUCCESS (0.001s)
[95.230425] Starting dynamic subtest: wc
[95.231418] Dynamic subtest wc: SUCCESS (0.000s)
[95.237768] Starting dynamic subtest: uc
[95.238715] Dynamic subtest uc: SUCCESS (0.000s)
[95.239681] Subtest faulting-read: SUCCESS (0.003s)
[95.324620] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[95.416214] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[95.417815] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[95.523070] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[95.901641] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[96.734828] [015/133] (924s left) gem_exec_schedule (pi-distinct-iova)
[96.910364] Starting subtest: pi-distinct-iova
[96.911496] Starting dynamic subtest: rcs0
[96.982442] Dynamic subtest rcs0: SUCCESS (0.080s)
[96.992047] Starting dynamic subtest: vcs0
[97.043224] Dynamic subtest vcs0: SUCCESS (0.060s)
[97.053407] Starting dynamic subtest: vcs1
[97.110872] Dynamic subtest vcs1: SUCCESS (0.067s)
[97.122578] Starting dynamic subtest: vecs0
[97.167653] Dynamic subtest vecs0: SUCCESS (0.057s)
[97.176797] Starting dynamic subtest: ccs0
[97.233867] Dynamic subtest ccs0: SUCCESS (0.066s)
[97.235349] Subtest pi-distinct-iova: SUCCESS (0.332s)
[98.979612] [016/133] (922s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[99.072863] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[99.074743] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[99.179324] [017/133] (921s left) drm_read (short-buffer-block)
[99.313350] Starting subtest: short-buffer-block
[99.314360] Subtest short-buffer-block: SUCCESS (0.000s)
[99.431087] [018/133] (921s left) perf (oa-formats)
[99.547793] Starting subtest: oa-formats
[99.548778] Starting dynamic subtest: 0-rcs0
[99.563097] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[99.569716] Starting dynamic subtest: 1-vcs0
[99.583982] Dynamic subtest 1-vcs0: SUCCESS (0.020s)
[99.585153] Subtest oa-formats: SUCCESS (0.037s)
[99.624626] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[99.716562] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[99.718449] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[99.789742] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[99.891441] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[99.892966] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[99.970654] [021/133] (921s left) kms_psr (pr-basic)
[100.055128] Starting subtest: pr-basic
[100.056926] Subtest pr-basic: SKIP (0.000s)
[100.131205] [022/133] (921s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[100.224243] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[100.225412] Starting dynamic subtest: pipe-A-eDP-1
[100.234365] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.245403] Starting dynamic subtest: pipe-B-eDP-1
[100.253663] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.260112] Starting dynamic subtest: pipe-C-eDP-1
[100.269344] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.280928] Starting dynamic subtest: pipe-D-eDP-1
[100.289796] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.291722] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[102.520575] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[102.895977] Subtest hdmi-mode-timings: SKIP (0.000s)
[103.720625] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[103.859903] Starting subtest: dp-mst-lic-type-0-hdcp14
[103.861917] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[103.959763] [025/133] (917s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[104.045558] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[104.047378] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[104.107410] [026/133] (917s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[104.187248] Starting subtest: primary-4-tiled-reflect-x-180
[111.115710] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.928s)
[112.319452] [027/133] (909s left) kms_flip (2x-flip-vs-panning-interruptible)
[112.424796] Starting subtest: 2x-flip-vs-panning-interruptible
[112.435697] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[112.505153] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[112.594997] Starting subtest: plain-flip-fb-recreate
[112.597580] Starting dynamic subtest: A-eDP1
[121.428531] Dynamic subtest A-eDP1: SUCCESS (8.830s)
[121.438772] Starting dynamic subtest: B-eDP1
[130.258641] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[130.270548] Starting dynamic subtest: C-eDP1
[139.090533] Dynamic subtest C-eDP1: SUCCESS (8.830s)
[139.099579] Starting dynamic subtest: D-eDP1
[147.922200] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[147.929187] Subtest plain-flip-fb-recreate: SUCCESS (35.330s)
[149.099447] [029/133] (872s left) gem_tiled_partial_pwrite_pread (writes)
[149.155201] Subtest writes: SKIP (0.000s)
[149.229733] [030/133] (872s left) gem_lmem_swapping (heavy-verify-random)
[149.265571] Subtest heavy-verify-random: SKIP (0.000s)
[149.305574] [031/133] (872s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[149.406892] Starting subtest: x-tiled-64bpp-rotate-90
[149.427627] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[149.541620] [032/133] (872s left) vgem_basic (debugfs)
[149.638360] Starting subtest: debugfs
[149.639342] Subtest debugfs: SUCCESS (0.000s)
[149.690691] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[149.692355] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[149.788383] Starting subtest: legacy-setmode
[149.789274] Starting dynamic subtest: pipe-A-eDP-1
[156.702523] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.914s)
[156.703503] Subtest legacy-setmode: SUCCESS (6.915s)
[157.557652] [034/133] (864s left) gem_pxp (reject-modify-context-protection-off-2)
[157.680678] Starting subtest: reject-modify-context-protection-off-2
[157.681925] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[157.783770] [035/133] (863s left) gem_exec_basic (basic)
[157.831324] Starting subtest: basic
[157.832177] Starting dynamic subtest: rcs0-smem
[157.836180] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[157.847718] Starting dynamic subtest: bcs0-smem
[157.848620] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[157.858784] Starting dynamic subtest: vcs0-smem
[157.859586] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[157.866066] Starting dynamic subtest: vcs1-smem
[157.866844] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[157.873177] Starting dynamic subtest: vecs0-smem
[157.874134] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[157.882391] Starting dynamic subtest: ccs0-smem
[157.883270] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[157.884090] Subtest basic: SUCCESS (0.020s)
[159.931166] [036/133] (861s left) api_intel_bb (offset-control)
[159.976269] Starting subtest: offset-control
[159.983850] Subtest offset-control: SUCCESS (0.008s)
[160.096615] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[160.182537] Starting subtest: basic-max-non-joiner
[160.184225] Subtest basic-max-non-joiner: SKIP (0.000s)
[160.247981] [038/133] (861s left) kms_addfb_basic (small-bo)
[160.329638] Starting subtest: small-bo
[160.330550] Subtest small-bo: SUCCESS (0.000s)
[160.411966] [039/133] (861s left) i915_query (query-topology-garbage-items)
[160.469723] Starting subtest: query-topology-garbage-items
[160.471021] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[160.562455] [040/133] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[160.658411] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[160.680395] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.022s)
[160.716717] [041/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[161.889857] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[161.891752] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[161.986237] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[162.051592] Starting subtest: cliprects-invalid
[162.052534] Subtest cliprects-invalid: SUCCESS (0.000s)
[162.160094] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[162.328644] Starting subtest: cursor-random-64x64
[162.334395] Starting dynamic subtest: pipe-A-eDP-1
[165.675598] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.342s)
[165.704143] Starting dynamic subtest: pipe-D-eDP-1
[169.670068] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.973s)
[169.670888] Subtest cursor-random-64x64: SUCCESS (7.342s)
[170.545775] [044/133] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[170.662437] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[170.664476] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[170.760713] [045/133] (851s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[170.850454] Starting subtest: 4-tiled-16bpp-rotate-180
[172.151432] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.301s)
[172.267760] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[172.315022] Starting subtest: create-valid-dumb
[172.315871] Subtest create-valid-dumb: SUCCESS (0.000s)
[172.401916] [047/133] (849s left) gem_softpin (zero)
[172.459466] Starting subtest: zero
[172.468280] Subtest zero: SUCCESS (0.008s)
[172.573082] [048/133] (849s left) gem_blits (basic)
[172.631545] Starting subtest: basic
[174.043035] Subtest basic: SUCCESS (1.404s)
[174.135708] [049/133] (848s left) gem_busy (close-race)
[174.189221] Starting subtest: close-race
[197.932768] Subtest close-race: SUCCESS (23.740s)
[198.302087] [050/133] (823s left) gem_exec_alignment (forked)
[198.407736] Starting subtest: forked
[239.810508] Subtest forked: SUCCESS (41.354s)
[239.845533] [051/133] (782s left) syncobj_eventfd (binary-wait-before-signal)
[239.957090] Starting subtest: binary-wait-before-signal
[239.985786] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[240.057291] [052/133] (782s left) prime_mmap (test_errors)
[240.103056] Starting subtest: test_errors
[240.103884] Starting dynamic subtest: test_errors-smem
[240.210719] Dynamic subtest test_errors-smem: SUCCESS (0.106s)
[240.212047] Subtest test_errors: SUCCESS (0.107s)
[240.306491] [053/133] (782s left) gem_ctx_persistence (heartbeat-stop)
[240.364365] Starting subtest: heartbeat-stop
[240.366190] Subtest heartbeat-stop: SKIP (0.000s)
[240.481958] [054/133] (781s left) gem_ctx_param (invalid-get-ringsize)
[240.528344] Starting subtest: invalid-get-ringsize
[240.530699] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[240.622686] [055/133] (781s left) i915_query (query-topology-matches-eu-total)
[240.663250] Starting subtest: query-topology-matches-eu-total
[240.664205] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[240.754334] [056/133] (781s left) kms_cursor_edge_walk (64x64-right-edge)
[240.846159] Starting subtest: 64x64-right-edge
[240.847061] Starting dynamic subtest: pipe-A-eDP-1
[244.296151] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[244.303769] Starting dynamic subtest: pipe-D-eDP-1
[247.412579] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[247.413506] Subtest 64x64-right-edge: SUCCESS (6.566s)
[248.222597] [057/133] (774s left) kms_plane (plane-position-covered)
[248.313690] Starting subtest: plane-position-covered
[248.839531] Starting dynamic subtest: pipe-A-plane-1
[250.100302] Dynamic subtest pipe-A-plane-1: SUCCESS (1.261s)
[250.107849] Starting dynamic subtest: pipe-A-plane-2
[251.355647] Dynamic subtest pipe-A-plane-2: SUCCESS (1.255s)
[251.363201] Starting dynamic subtest: pipe-A-plane-3
[252.699061] Dynamic subtest pipe-A-plane-3: SUCCESS (1.341s)
[252.706780] Starting dynamic subtest: pipe-A-plane-4
[254.020462] Dynamic subtest pipe-A-plane-4: SUCCESS (1.321s)
[254.030412] Starting dynamic subtest: pipe-A-plane-5
[254.048279] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[255.262715] Starting dynamic subtest: pipe-B-plane-1
[256.605597] Dynamic subtest pipe-B-plane-1: SUCCESS (1.351s)
[256.613310] Starting dynamic subtest: pipe-B-plane-2
[257.902044] Dynamic subtest pipe-B-plane-2: SUCCESS (1.294s)
[257.912317] Starting dynamic subtest: pipe-B-plane-3
[259.233104] Dynamic subtest pipe-B-plane-3: SUCCESS (1.331s)
[259.240776] Starting dynamic subtest: pipe-B-plane-4
[260.552778] Dynamic subtest pipe-B-plane-4: SUCCESS (1.319s)
[260.560541] Starting dynamic subtest: pipe-B-plane-5
[260.584876] Dynamic subtest pipe-B-plane-5: SUCCESS (0.031s)
[260.585682] Subtest plane-position-covered: SUCCESS (12.271s)
[261.372892] [058/133] (761s left) kms_frontbuffer_tracking (psr-suspend)
[261.468888] Starting subtest: psr-suspend
[299.659186] Subtest psr-suspend: SUCCESS (9.716s)
[306.794823] [059/133] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[306.891100] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[306.893615] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[306.989872] [060/133] (722s left) gem_exec_schedule (fairslice)
[307.048019] Starting subtest: fairslice
[307.049028] Starting dynamic subtest: rcs0
[309.078078] Dynamic subtest rcs0: SUCCESS (1.956s)
[309.088808] Starting dynamic subtest: bcs0
[311.093779] Dynamic subtest bcs0: SUCCESS (1.968s)
[311.107911] Starting dynamic subtest: vcs0
[313.114624] Dynamic subtest vcs0: SUCCESS (1.979s)
[313.124984] Starting dynamic subtest: vcs1
[315.133216] Dynamic subtest vcs1: SUCCESS (1.989s)
[315.143916] Starting dynamic subtest: vecs0
[317.154165] Dynamic subtest vecs0: SUCCESS (1.996s)
[317.165404] Starting dynamic subtest: ccs0
[319.178236] Dynamic subtest ccs0: SUCCESS (2.009s)
[319.179218] Subtest fairslice: SUCCESS (11.903s)
[319.485407] [061/133] (710s left) sw_sync (alloc_fence_invalid_timeline)
[319.524112] Starting subtest: alloc_fence_invalid_timeline
[319.525044] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[319.581193] [062/133] (710s left) gem_exec_whisper (basic-fds-forked)
[319.639976] Starting subtest: basic-fds-forked
[344.331733] Subtest basic-fds-forked: SUCCESS (24.586s)
[344.474098] [063/133] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[344.562150] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[344.563855] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[344.660066] [064/133] (685s left) gem_vm_create (execbuf)
[344.709800] Starting subtest: execbuf
[344.717541] Subtest execbuf: SUCCESS (0.008s)
[344.827068] [065/133] (684s left) kms_cursor_crc (cursor-onscreen-256x85)
[345.077049] Starting subtest: cursor-onscreen-256x85
[345.121936] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[345.292201] [066/133] (684s left) kms_plane_alpha_blend (coverage-7efc)
[345.379477] Starting subtest: coverage-7efc
[345.681718] Starting dynamic subtest: pipe-A-eDP-1
[346.282920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[346.311843] Starting dynamic subtest: pipe-D-eDP-1
[347.593532] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s)
[347.594555] Subtest coverage-7efc: SUCCESS (2.213s)
[348.433053] [067/133] (681s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[348.528587] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[348.529506] Starting dynamic subtest: pipe-A
[348.548995] Dynamic subtest pipe-A: SKIP (0.018s)
[348.557596] Starting dynamic subtest: pipe-B
[348.580426] Dynamic subtest pipe-B: SKIP (0.031s)
[348.588730] Starting dynamic subtest: pipe-C
[348.613104] Dynamic subtest pipe-C: SKIP (0.032s)
[348.621653] Starting dynamic subtest: pipe-D
[348.645238] Dynamic subtest pipe-D: SKIP (0.033s)
[348.646984] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.116s)
[348.725391] [068/133] (681s left) vgem_basic (busy-fence)
[348.761684] Starting subtest: busy-fence
[348.762533] Subtest busy-fence: SUCCESS (0.000s)
[348.817602] [069/133] (681s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[348.899787] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[348.930879] Starting dynamic subtest: pipe-A-plane-0
[349.408598] Dynamic subtest pipe-A-plane-0: SUCCESS (0.478s)
[349.418549] Starting dynamic subtest: pipe-A-plane-3
[349.664283] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[349.673077] Starting dynamic subtest: pipe-A-plane-5
[349.674772] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[350.735694] Starting dynamic subtest: pipe-B-plane-0
[351.161155] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[351.169530] Starting dynamic subtest: pipe-B-plane-3
[351.416747] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[351.427545] Starting dynamic subtest: pipe-B-plane-5
[351.429245] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[351.737065] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.835s)
[352.607663] [070/133] (677s left) kms_addfb_basic (invalid-set-prop-any)
[352.667743] Starting subtest: invalid-set-prop-any
[352.668541] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[352.800950] [071/133] (677s left) kms_addfb_basic (size-max)
[352.882264] Starting subtest: size-max
[352.883201] Subtest size-max: SUCCESS (0.000s)
[352.980600] [072/133] (677s left) kms_addfb_basic (bad-pitch-128)
[353.025355] Starting subtest: bad-pitch-128
[353.026291] Subtest bad-pitch-128: SUCCESS (0.000s)
[353.173794] [073/133] (676s left) syncobj_timeline (single-wait-available-submitted)
[353.227477] Starting subtest: single-wait-available-submitted
[353.228461] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[353.322926] [074/133] (676s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[353.422435] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[354.468203] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.046s)
[354.588518] [075/133] (675s left) gem_pread (exhaustion)
[354.640905] Subtest exhaustion: SKIP (0.000s)
[354.703621] [076/133] (675s left) kms_frontbuffer_tracking (psr-1p-rte)
[354.784753] Starting subtest: psr-1p-rte
[360.232346] Subtest psr-1p-rte: SUCCESS (5.446s)
[360.360807] [077/133] (669s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[360.483995] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[378.089138] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.597s)
[378.885506] [078/133] (651s left) api_intel_allocator (fork-simple-once)
[378.937337] Starting subtest: fork-simple-once
[378.950092] Subtest fork-simple-once: SUCCESS (0.015s)
[379.064362] [079/133] (651s left) gem_set_tiling_vs_pwrite
[379.180475] [080/133] (651s left) kms_pm_backlight (brightness-with-dpms)
[379.262461] Starting subtest: brightness-with-dpms
[379.313756] Starting dynamic subtest: eDP-1
[381.681763] Dynamic subtest eDP-1: SUCCESS (2.366s)
[381.682876] Subtest brightness-with-dpms: SUCCESS (2.417s)
[382.544821] [081/133] (647s left) kms_lease (lease-invalid-crtc)
[382.642554] Starting subtest: lease-invalid-crtc
[382.643563] Starting dynamic subtest: pipe-A-eDP-1
[382.644466] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[382.654126] Starting dynamic subtest: pipe-B-eDP-1
[382.654995] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[382.663135] Starting dynamic subtest: pipe-C-eDP-1
[382.664022] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[382.672228] Starting dynamic subtest: pipe-D-eDP-1
[382.673047] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[382.674079] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[382.715046] [082/133] (647s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[382.807566] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[382.809330] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[382.901026] [083/133] (647s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[382.991942] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[389.988184] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.991s)
[390.107904] [084/133] (640s left) kms_dp_linktrain_fallback (dp-fallback)
[390.199705] Starting subtest: dp-fallback
[390.202250] Subtest dp-fallback: SKIP (0.000s)
[390.267950] [085/133] (640s left) kms_vblank (ts-continuation-idle)
[390.360052] Starting subtest: ts-continuation-idle
[390.360870] Starting dynamic subtest: pipe-A-eDP-1
[390.757253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[390.767610] Starting dynamic subtest: pipe-D-eDP-1
[391.877148] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.116s)
[391.878079] Subtest ts-continuation-idle: SUCCESS (1.516s)
[392.741519] [086/133] (637s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[392.828553] Starting subtest: fbc-psr-cursor-mmap-gtt
[392.829418] Starting dynamic subtest: eDP-1
[392.831135] Dynamic subtest eDP-1: SKIP (0.000s)
[392.833008] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[392.910892] [087/133] (637s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[393.031523] Starting subtest: cursor-vs-flip-varying-size
[424.485070] Subtest cursor-vs-flip-varying-size: SUCCESS (31.452s)
[425.303017] [088/133] (605s left) i915_drm_fdinfo (busy-check-all)
[425.339512] Starting subtest: busy-check-all
[425.340500] Starting dynamic subtest: rcs0
[425.345532] Dynamic subtest rcs0: SKIP (0.004s)
[425.361115] Starting dynamic subtest: bcs0
[425.363366] Dynamic subtest bcs0: SKIP (0.000s)
[425.376653] Starting dynamic subtest: vcs0
[425.378640] Dynamic subtest vcs0: SKIP (0.000s)
[425.391137] Starting dynamic subtest: vcs1
[425.393408] Dynamic subtest vcs1: SKIP (0.000s)
[425.401878] Starting dynamic subtest: vecs0
[425.404027] Dynamic subtest vecs0: SKIP (0.000s)
[425.412379] Starting dynamic subtest: ccs0
[425.414335] Dynamic subtest ccs0: SKIP (0.000s)
[425.416029] Subtest busy-check-all: SKIP (0.009s)
[425.447144] [089/133] (605s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[425.561681] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[425.562610] Starting dynamic subtest: pipe-A-eDP-1
[425.570663] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[425.584871] Starting dynamic subtest: pipe-B-eDP-1
[425.593925] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[425.602317] Starting dynamic subtest: pipe-C-eDP-1
[425.609535] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[425.617797] Starting dynamic subtest: pipe-D-eDP-1
[425.625185] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[425.625998] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[427.837545] [090/133] (602s left) prime_busy (before-wait)
[427.888731] Starting subtest: before-wait
[427.890502] Starting dynamic subtest: rcs0
[427.922598] Dynamic subtest rcs0: SUCCESS (0.032s)
[427.932408] Starting dynamic subtest: bcs0
[427.968237] Dynamic subtest bcs0: SUCCESS (0.045s)
[427.977133] Starting dynamic subtest: vcs0
[428.009267] Dynamic subtest vcs0: SUCCESS (0.040s)
[428.017669] Starting dynamic subtest: vcs1
[428.050222] Dynamic subtest vcs1: SUCCESS (0.040s)
[428.058759] Starting dynamic subtest: vecs0
[428.091288] Dynamic subtest vecs0: SUCCESS (0.040s)
[428.099607] Starting dynamic subtest: ccs0
[428.132386] Dynamic subtest ccs0: SUCCESS (0.040s)
[428.250660] Subtest before-wait: SUCCESS (0.353s)
[428.311816] [091/133] (602s left) gem_ppgtt (blt-vs-render-ctx0)
[428.360446] Starting subtest: blt-vs-render-ctx0
[461.143864] Subtest blt-vs-render-ctx0: SUCCESS (32.766s)
[461.266111] [092/133] (569s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[461.454186] Starting subtest: cursorB-vs-flipB-atomic
[461.475825] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[461.572095] [093/133] (569s left) gem_exec_reloc (basic-wc-read-active)
[461.626582] Subtest basic-wc-read-active: SKIP (0.000s)
[461.694530] [094/133] (569s left) gem_exec_fence (syncobj-import)
[462.170218] Starting subtest: syncobj-import
[462.175212] Subtest syncobj-import: SUCCESS (0.005s)
[463.466015] [095/133] (567s left) kms_psr (fbc-psr2-sprite-blt)
[463.559454] Starting subtest: fbc-psr2-sprite-blt
[463.560277] Starting dynamic subtest: eDP-1
[463.562043] Dynamic subtest eDP-1: SKIP (0.000s)
[463.563882] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[463.634570] [096/133] (567s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[463.723607] Starting subtest: plane-lut1d-post-ctm3x4
[463.882147] Starting dynamic subtest: pipe-A-plane-0
[464.082086] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[464.091476] Starting dynamic subtest: pipe-A-plane-1
[464.248766] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[464.257828] Starting dynamic subtest: pipe-A-plane-2
[464.393459] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[465.539846] Starting dynamic subtest: pipe-B-plane-0
[465.697735] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[465.710092] Starting dynamic subtest: pipe-B-plane-1
[465.863887] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[465.872992] Starting dynamic subtest: pipe-B-plane-2
[466.030637] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[467.286785] Starting dynamic subtest: pipe-C-plane-0
[467.434377] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[467.446480] Starting dynamic subtest: pipe-C-plane-1
[467.579242] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[467.592130] Starting dynamic subtest: pipe-C-plane-2
[467.745102] Dynamic subtest pipe-C-plane-2: SUCCESS (0.165s)
[468.924676] Starting dynamic subtest: pipe-D-plane-0
[469.071624] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[469.081025] Starting dynamic subtest: pipe-D-plane-1
[469.238325] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[469.253824] Starting dynamic subtest: pipe-D-plane-2
[469.405712] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[469.697010] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.972s)
[470.497612] [097/133] (560s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[470.556497] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[470.558209] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[470.730941] [098/133] (560s left) kms_big_fb (linear-8bpp-rotate-180)
[470.825347] Starting subtest: linear-8bpp-rotate-180
[472.131363] Subtest linear-8bpp-rotate-180: SUCCESS (1.305s)
[472.252847] [099/133] (558s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[472.342398] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[472.344099] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[472.428846] [100/133] (558s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[472.526244] Starting subtest: extended-modeset-hang-oldfb-with-reset
[472.527119] Starting dynamic subtest: pipe-A
[484.092622] Dynamic subtest pipe-A: SUCCESS (11.561s)
[484.102045] Starting dynamic subtest: pipe-D
[496.360215] Dynamic subtest pipe-D: SUCCESS (12.262s)
[496.361310] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.827s)
[497.149754] [101/133] (533s left) gem_exec_schedule (timeslicing)
[497.208583] Starting subtest: timeslicing
[497.209455] Starting dynamic subtest: rcs0
[497.229592] Dynamic subtest rcs0: SUCCESS (0.021s)
[497.241075] Starting dynamic subtest: bcs0
[497.250629] Dynamic subtest bcs0: SUCCESS (0.020s)
[497.262024] Starting dynamic subtest: vcs0
[497.270914] Dynamic subtest vcs0: SUCCESS (0.020s)
[497.282731] Starting dynamic subtest: vcs1
[497.290161] Dynamic subtest vcs1: SUCCESS (0.019s)
[497.298874] Starting dynamic subtest: vecs0
[497.311067] Dynamic subtest vecs0: SUCCESS (0.020s)
[497.319805] Starting dynamic subtest: ccs0
[497.333914] Dynamic subtest ccs0: SUCCESS (0.022s)
[497.335045] Subtest timeslicing: SUCCESS (0.127s)
[498.421237] [102/133] (532s left) kms_chamelium_color (ctm-0-25)
[498.517349] Subtest ctm-0-25: SKIP (0.000s)
[498.561056] [103/133] (532s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[498.657046] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[498.658070] Starting dynamic subtest: pipe-A-eDP-1
[498.746150] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[498.755928] Starting dynamic subtest: pipe-B-eDP-1
[499.936597] Dynamic subtest pipe-B-eDP-1: SKIP (1.189s)
[499.938345] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.280s)
[501.116569] [104/133] (530s left) gem_mmap (short-mmap)
[501.165952] Subtest short-mmap: SKIP (0.000s)
[501.228885] [105/133] (529s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[501.275503] Starting subtest: multi-wait-available-unsubmitted-submitted
[501.276412] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[501.375362] [106/133] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[501.461297] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[501.462887] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[501.550345] [107/133] (529s left) kms_getfb (getfb2-accept-nv12)
[501.640718] Starting subtest: getfb2-accept-nv12
[501.641723] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[501.731486] [108/133] (529s left) syncobj_timeline (invalid-signal-zero-handles)
[501.773652] Starting subtest: invalid-signal-zero-handles
[501.774718] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[501.861688] [109/133] (529s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[501.959603] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[501.961518] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[502.035355] [110/133] (529s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[502.112797] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[502.113662] Starting dynamic subtest: pipe-A-eDP-1
[502.143635] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[502.155079] Starting dynamic subtest: pipe-B-eDP-1
[502.182277] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[502.191570] Starting dynamic subtest: pipe-C-eDP-1
[502.212983] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[502.224232] Starting dynamic subtest: pipe-D-eDP-1
[502.245132] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[502.246766] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[504.316033] [111/133] (527s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[504.410750] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[504.422145] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[504.513205] [112/133] (526s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[504.613591] Starting subtest: async-flip-with-page-flip-events-tiled
[504.986042] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[507.791532] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[507.800643] Starting dynamic subtest: pipe-A-eDP-1-4
[509.967535] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[509.979654] Starting dynamic subtest: pipe-A-eDP-1-4
[511.977213] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[511.987297] Starting dynamic subtest: pipe-A-eDP-1-x
[514.180933] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.201s)
[514.553402] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[517.326045] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[517.335464] Starting dynamic subtest: pipe-B-eDP-1-4
[519.512910] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[519.524638] Starting dynamic subtest: pipe-B-eDP-1-4
[521.523018] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[521.535298] Starting dynamic subtest: pipe-B-eDP-1-x
[523.714299] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[524.080759] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[526.854455] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[526.864364] Starting dynamic subtest: pipe-C-eDP-1-4
[529.029857] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[529.041599] Starting dynamic subtest: pipe-C-eDP-1-4
[531.039631] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[531.049242] Starting dynamic subtest: pipe-C-eDP-1-x
[533.228837] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[533.607347] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[536.381626] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.774s)
[536.391106] Starting dynamic subtest: pipe-D-eDP-1-4
[538.556213] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[538.568055] Starting dynamic subtest: pipe-D-eDP-1-4
[540.564356] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.006s)
[540.574103] Starting dynamic subtest: pipe-D-eDP-1-x
[542.742718] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[542.743830] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.117s)
[543.956938] [113/133] (487s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[544.072370] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[544.074060] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[544.171546] [114/133] (487s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[544.223566] Starting subtest: etime-multi-wait-for-submit-submitted
[544.325907] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[544.399532] [115/133] (487s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[546.523908] Starting subtest: modeset-non-lpsp-stress-no-wait
[546.575103] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.052s)
[546.925736] [116/133] (484s left) gem_exec_params (sol-reset-invalid)
[546.981413] Starting subtest: sol-reset-invalid
[546.984995] Subtest sol-reset-invalid: SUCCESS (0.002s)
[548.438200] [117/133] (483s left) gem_mmap_gtt (cpuset-big-copy)
[548.484742] Subtest cpuset-big-copy: SKIP (0.000s)
[548.540670] [118/133] (483s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[548.631189] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[556.568979] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.940s)
[556.678394] [119/133] (475s left) kms_psr (psr2-sprite-plane-onoff)
[556.770636] Starting subtest: psr2-sprite-plane-onoff
[556.771555] Starting dynamic subtest: eDP-1
[558.492273] Dynamic subtest eDP-1: SUCCESS (1.722s)
[558.493122] Subtest psr2-sprite-plane-onoff: SUCCESS (1.723s)
[559.345720] [120/133] (472s left) kms_dsc (dsc-with-output-formats)
[559.431737] Starting subtest: dsc-with-output-formats
[559.440365] Subtest dsc-with-output-formats: SKIP (0.000s)
[559.500753] [121/133] (472s left) gen3_mixed_blits
[559.609869] [122/133] (472s left) gem_mmap_offset (clear-via-pagefault)
[559.656465] Starting subtest: clear-via-pagefault
[559.657480] Starting dynamic subtest: smem0
[591.897117] Dynamic subtest smem0: SUCCESS (32.232s)
[591.898032] Subtest clear-via-pagefault: SUCCESS (32.234s)
[592.012648] [123/133] (439s left) gem_eio (reset-stress)
[592.271976] Starting subtest: reset-stress
[592.272834] Starting dynamic subtest: render
[597.489214] Dynamic subtest render: SUCCESS (5.216s)
[597.505886] Starting dynamic subtest: bsd1
[615.902911] Dynamic subtest bsd1: SUCCESS (18.411s)
[615.918542] Starting dynamic subtest: bsd2
[633.897612] Dynamic subtest bsd2: SUCCESS (17.990s)
[633.913859] Starting dynamic subtest: blt
[633.916023] Dynamic subtest blt: SKIP (0.000s)
[633.925037] Starting dynamic subtest: vebox
[651.882979] Dynamic subtest vebox: SUCCESS (17.981s)
[651.884210] Subtest reset-stress: SUCCESS (59.602s)
[653.369264] [124/133] (378s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[653.431916] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[653.432853] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[653.547370] [125/133] (378s left) kms_vblank (query-busy-hang)
[653.636978] Starting subtest: query-busy-hang
[653.638012] Starting dynamic subtest: pipe-A-eDP-1
[655.522538] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[655.533222] Starting dynamic subtest: pipe-D-eDP-1
[658.109444] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[658.110485] Subtest query-busy-hang: SUCCESS (4.473s)
[658.901242] [126/133] (373s left) kms_psr (fbc-pr-cursor-plane-onoff)
[659.000576] Starting subtest: fbc-pr-cursor-plane-onoff
[659.002391] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[659.103457] [127/133] (372s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[659.195246] Starting subtest: psr-1p-primscrn-cur-indfb-move
[666.543626] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.347s)
[666.674569] [128/133] (365s left) tools_test (sysfs_l3_parity)
[666.713914] Starting subtest: sysfs_l3_parity
[666.788120] Subtest sysfs_l3_parity: SKIP (0.077s)
[666.842789] [129/133] (365s left) kms_vblank (crtc-id)
[666.923861] Starting subtest: crtc-id
[666.924888] Starting dynamic subtest: pipe-A-eDP-1
[667.384225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[667.396077] Starting dynamic subtest: pipe-D-eDP-1
[668.479247] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.091s)
[668.480114] Subtest crtc-id: SUCCESS (1.556s)
[669.309624] [130/133] (362s left) gem_ctx_engines (independent)
[669.358990] Starting subtest: independent
[669.360012] Starting dynamic subtest: rcs0
[669.519907] Dynamic subtest rcs0: SUCCESS (0.151s)
[669.529936] Starting dynamic subtest: bcs0
[669.689069] Dynamic subtest bcs0: SUCCESS (0.168s)
[669.699338] Starting dynamic subtest: vcs0
[669.863678] Dynamic subtest vcs0: SUCCESS (0.174s)
[669.873629] Starting dynamic subtest: vcs1
[670.040581] Dynamic subtest vcs1: SUCCESS (0.176s)
[670.049862] Starting dynamic subtest: vecs0
[670.209672] Dynamic subtest vecs0: SUCCESS (0.166s)
[670.219665] Starting dynamic subtest: ccs0
[670.401864] Dynamic subtest ccs0: SUCCESS (0.192s)
[670.415103] Starting dynamic subtest: all-engines
[671.060124] Dynamic subtest all-engines: SUCCESS (0.657s)
[671.061120] Subtest independent: SUCCESS (1.693s)
[671.532941] [131/133] (360s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[671.624973] Starting subtest: flip-vs-dpms-on-nop-interruptible
[671.627500] Starting dynamic subtest: A-eDP1
[673.501994] Dynamic subtest A-eDP1: SUCCESS (1.874s)
[673.513279] Starting dynamic subtest: B-eDP1
[675.329361] Dynamic subtest B-eDP1: SUCCESS (1.824s)
[675.341685] Starting dynamic subtest: C-eDP1
[677.159998] Dynamic subtest C-eDP1: SUCCESS (1.826s)
[677.170929] Starting dynamic subtest: D-eDP1
[678.987716] Dynamic subtest D-eDP1: SUCCESS (1.827s)
[678.991603] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.364s)
[680.173363] [132/133] (352s left) kms_plane_lowres (tiling-x)
[680.256515] Starting subtest: tiling-x
[680.257419] Starting dynamic subtest: pipe-A-eDP-1
[680.259157] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[680.554910] Starting dynamic subtest: pipe-B-eDP-1
[680.556578] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[680.566227] Starting dynamic subtest: pipe-C-eDP-1
[680.568058] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[680.576782] Starting dynamic subtest: pipe-D-eDP-1
[680.578728] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[680.580461] Subtest tiling-x: SKIP (0.296s)
[681.402225] [133/133] (350s left) i915_pm_freq_api (freq-reset)
[681.464646] Starting subtest: freq-reset
[681.465533] Starting dynamic subtest: gt0
[681.660115] Dynamic subtest gt0: SUCCESS (0.194s)
[681.670093] Starting dynamic subtest: gt1
[681.847848] Dynamic subtest gt1: SUCCESS (0.176s)
[681.848720] Subtest freq-reset: SUCCESS (0.372s)
[681.907347] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_pm_rpm
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: drm_read
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: kms_atomic_interruptible
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: gem_exec_basic
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_joiner
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: dumb_buffer
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: gem_blits
results: parsing output: 48/ for test: gem_busy
results: parsing output: 49/ for test: gem_exec_alignment
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_vm_create
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_pread
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_dp_linktrain_fallback
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: prime_busy
results: parsing output: 90/ for test: gem_ppgtt
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_mmap
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_dsc
results: parsing output: 120/ for test: gen3_mixed_blits
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: tools_test
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_ctx_engines
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_plane_lowres
results: parsing output: 132/ for test: i915_pm_freq_api
Done.