[57.597762] Initializing watchdogs
[57.597854]   /dev/watchdog0
[57.613450] [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.618073] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.620818] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.624198] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[57.752723] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[57.757151] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[57.854827] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[57.960107] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[57.964248] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[58.054256] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[58.157626] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[58.842574] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[59.014542] [004/133] (959s left) gen7_exec_parse (basic-offset)
[59.085611] Subtest basic-offset: SKIP (0.000s)
[59.151906] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[59.241965] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[63.558378] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.295s)
[64.694418] [006/133] (953s left) tools_test (tools_test)
[64.747306] Starting subtest: tools_test
[64.800582] Subtest tools_test: SUCCESS (0.068s)
[64.879899] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[64.980372] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[64.985260] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[66.121225] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[66.221692] Starting subtest: modeset-vs-vblank-race
[66.224157] Starting dynamic subtest: A-eDP1
[70.952407] Dynamic subtest A-eDP1: SUCCESS (4.722s)
[70.964183] Starting dynamic subtest: B-eDP1
[75.694501] Dynamic subtest B-eDP1: SUCCESS (4.735s)
[75.704743] Starting dynamic subtest: C-eDP1
[80.406435] Dynamic subtest C-eDP1: SUCCESS (4.706s)
[80.416240] Starting dynamic subtest: D-eDP1
[84.968909] Dynamic subtest D-eDP1: SUCCESS (4.558s)
[84.973844] Subtest modeset-vs-vblank-race: SUCCESS (18.731s)
[86.133937] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[88.076815] Starting subtest: reg-read-ioctl
[90.368880] Subtest reg-read-ioctl: SUCCESS (2.294s)
[90.753984] [010/133] (927s left) gem_exec_balancer (hang)
[91.023486] Starting subtest: hang
[92.885295] Subtest hang: SUCCESS (1.864s)
[93.009066] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[93.103977] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[93.108327] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[93.173994] [012/133] (925s left) perf_pmu (faulting-read)
[93.215478] Starting subtest: faulting-read
[93.217843] Starting dynamic subtest: wb
[93.220627] Dynamic subtest wb: SUCCESS (0.001s)
[93.228621] Starting dynamic subtest: wc
[93.230824] Dynamic subtest wc: SUCCESS (0.000s)
[93.238581] Starting dynamic subtest: uc
[93.240788] Dynamic subtest uc: SUCCESS (0.000s)
[93.242992] Subtest faulting-read: SUCCESS (0.002s)
[93.310770] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[93.401742] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[93.405913] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[93.510740] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[93.884675] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[94.669356] [015/133] (924s left) gem_exec_schedule (pi-distinct-iova)
[94.847554] Starting subtest: pi-distinct-iova
[94.850073] Starting dynamic subtest: rcs0
[94.922803] Dynamic subtest rcs0: SUCCESS (0.077s)
[94.933713] Starting dynamic subtest: vcs0
[94.982913] Dynamic subtest vcs0: SUCCESS (0.060s)
[94.993081] Starting dynamic subtest: vcs1
[95.052406] Dynamic subtest vcs1: SUCCESS (0.069s)
[95.064145] Starting dynamic subtest: vecs0
[95.119525] Dynamic subtest vecs0: SUCCESS (0.067s)
[95.129422] Starting dynamic subtest: ccs0
[95.181849] Dynamic subtest ccs0: SUCCESS (0.060s)
[95.184548] Subtest pi-distinct-iova: SUCCESS (0.335s)
[97.004846] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[97.106686] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[97.111692] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[97.201318] [017/133] (921s left) drm_read (short-buffer-block)
[97.346454] Starting subtest: short-buffer-block
[97.348837] Subtest short-buffer-block: SUCCESS (0.000s)
[97.476073] [018/133] (921s left) perf (oa-formats)
[97.605641] Starting subtest: oa-formats
[97.607989] Starting dynamic subtest: 0-rcs0
[97.618657] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[97.628118] Starting dynamic subtest: 1-vcs0
[97.638852] Dynamic subtest 1-vcs0: SUCCESS (0.020s)
[97.641236] Subtest oa-formats: SUCCESS (0.035s)
[97.694552] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[97.797440] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[97.801523] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[97.889773] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[97.987336] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[97.990860] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[98.090775] [021/133] (920s left) kms_psr (pr-basic)
[98.188362] Starting subtest: pr-basic
[98.191840] Subtest pr-basic: SKIP (0.000s)
[98.260846] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[98.345309] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[98.347434] Starting dynamic subtest: pipe-A-eDP-1
[98.367108] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.378705] Starting dynamic subtest: pipe-B-eDP-1
[98.396361] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.404145] Starting dynamic subtest: pipe-C-eDP-1
[98.421659] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.429720] Starting dynamic subtest: pipe-D-eDP-1
[98.447581] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.450981] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[100.653788] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[101.042818] Subtest hdmi-mode-timings: SKIP (0.000s)
[101.854273] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[102.001895] Starting subtest: dp-mst-lic-type-0-hdcp14
[102.006422] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[102.131076] [025/133] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[102.237139] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[102.241325] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[102.304815] [026/133] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[102.402538] Starting subtest: primary-4-tiled-reflect-x-180
[109.325206] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.922s)
[110.546356] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[110.641656] Starting subtest: 2x-flip-vs-panning-interruptible
[110.662198] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.019s)
[110.744383] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[110.841761] Starting subtest: plain-flip-fb-recreate
[110.843975] Starting dynamic subtest: A-eDP1
[119.733057] Dynamic subtest A-eDP1: SUCCESS (8.891s)
[119.743143] Starting dynamic subtest: B-eDP1
[128.564471] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[128.572512] Starting dynamic subtest: C-eDP1
[137.375621] Dynamic subtest C-eDP1: SUCCESS (8.808s)
[137.386646] Starting dynamic subtest: D-eDP1
[146.207311] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[146.211261] Subtest plain-flip-fb-recreate: SUCCESS (35.368s)
[147.383542] [029/133] (871s left) gem_tiled_partial_pwrite_pread (writes)
[147.451972] Subtest writes: SKIP (0.000s)
[147.520725] [030/133] (871s left) gem_lmem_swapping (heavy-verify-random)
[147.564453] Subtest heavy-verify-random: SKIP (0.000s)
[147.608118] [031/133] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[147.711485] Starting subtest: x-tiled-64bpp-rotate-90
[147.730685] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[147.843127] [032/133] (871s left) vgem_basic (debugfs)
[147.942619] Starting subtest: debugfs
[147.944636] Subtest debugfs: SUCCESS (0.000s)
[147.998650] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[148.001730] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[148.104203] Starting subtest: legacy-setmode
[148.106474] Starting dynamic subtest: pipe-A-eDP-1
[154.982565] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.876s)
[154.984615] Subtest legacy-setmode: SUCCESS (6.877s)
[155.784180] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[155.911638] Starting subtest: reject-modify-context-protection-off-2
[155.914073] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[156.024328] [035/133] (863s left) gem_exec_basic (basic)
[156.082302] Starting subtest: basic
[156.084707] Starting dynamic subtest: rcs0-smem
[156.086971] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[156.097588] Starting dynamic subtest: bcs0-smem
[156.099716] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[156.108462] Starting dynamic subtest: vcs0-smem
[156.110605] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[156.118531] Starting dynamic subtest: vcs1-smem
[156.120650] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[156.128163] Starting dynamic subtest: vecs0-smem
[156.130287] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[156.138242] Starting dynamic subtest: ccs0-smem
[156.140305] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[156.142408] Subtest basic: SUCCESS (0.012s)
[157.948679] [036/133] (861s left) api_intel_bb (offset-control)
[157.997177] Starting subtest: offset-control
[158.002426] Subtest offset-control: SUCCESS (0.008s)
[158.118903] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[158.217615] Starting subtest: basic-max-non-joiner
[158.221851] Subtest basic-max-non-joiner: SKIP (0.000s)
[158.295518] [038/133] (861s left) kms_addfb_basic (small-bo)
[158.390975] Starting subtest: small-bo
[158.392914] Subtest small-bo: SUCCESS (0.000s)
[158.491609] [039/133] (861s left) i915_query (query-topology-garbage-items)
[158.548695] Starting subtest: query-topology-garbage-items
[158.550818] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[158.633458] [040/133] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[158.725432] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[158.746396] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[158.785435] [041/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[159.909015] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[159.913474] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[160.031515] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[160.082668] Starting subtest: cliprects-invalid
[160.084598] Subtest cliprects-invalid: SUCCESS (0.000s)
[160.173626] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[160.339748] Starting subtest: cursor-random-64x64
[160.344920] Starting dynamic subtest: pipe-A-eDP-1
[163.651409] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.307s)
[163.682689] Starting dynamic subtest: pipe-D-eDP-1
[167.682801] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.010s)
[167.685289] Subtest cursor-random-64x64: SUCCESS (7.343s)
[168.554167] [044/133] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[168.663487] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[168.667945] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[168.776995] [045/133] (851s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[168.883399] Starting subtest: 4-tiled-16bpp-rotate-180
[170.240334] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.357s)
[170.374772] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[170.431514] Starting subtest: create-valid-dumb
[170.433492] Subtest create-valid-dumb: SUCCESS (0.000s)
[170.523427] [047/133] (849s left) gem_softpin (zero)
[170.585715] Starting subtest: zero
[170.590046] Subtest zero: SUCCESS (0.004s)
[170.721071] [048/133] (849s left) gem_blits (basic)
[170.778078] Starting subtest: basic
[172.187771] Subtest basic: SUCCESS (1.409s)
[172.310938] [049/133] (847s left) gem_busy (close-race)
[172.374057] Starting subtest: close-race
[197.848749] Subtest close-race: SUCCESS (25.471s)
[198.204478] [050/133] (821s left) gem_exec_alignment (forked)
[198.313107] Starting subtest: forked
[238.400875] Subtest forked: SUCCESS (40.081s)
[238.485494] [051/133] (781s left) syncobj_eventfd (binary-wait-before-signal)
[238.581579] Starting subtest: binary-wait-before-signal
[238.612425] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[238.715727] [052/133] (781s left) prime_mmap (test_errors)
[238.772633] Starting subtest: test_errors
[238.775025] Starting dynamic subtest: test_errors-smem
[238.877148] Dynamic subtest test_errors-smem: SUCCESS (0.102s)
[238.879926] Subtest test_errors: SUCCESS (0.103s)
[238.971073] [053/133] (781s left) gem_ctx_persistence (heartbeat-stop)
[239.033619] Starting subtest: heartbeat-stop
[239.037932] Subtest heartbeat-stop: SKIP (0.000s)
[239.133920] [054/133] (781s left) gem_ctx_param (invalid-get-ringsize)
[239.195963] Starting subtest: invalid-get-ringsize
[239.198358] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[239.303084] [055/133] (781s left) i915_query (query-topology-matches-eu-total)
[239.360084] Starting subtest: query-topology-matches-eu-total
[239.362487] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[239.474137] [056/133] (780s left) kms_cursor_edge_walk (64x64-right-edge)
[239.568893] Starting subtest: 64x64-right-edge
[239.571219] Starting dynamic subtest: pipe-A-eDP-1
[243.019892] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[243.032378] Starting dynamic subtest: pipe-D-eDP-1
[246.128195] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.104s)
[246.130457] Subtest 64x64-right-edge: SUCCESS (6.559s)
[246.954799] [057/133] (773s left) kms_plane (plane-position-covered)
[247.053063] Starting subtest: plane-position-covered
[247.576194] Starting dynamic subtest: pipe-A-plane-1
[248.846967] Dynamic subtest pipe-A-plane-1: SUCCESS (1.273s)
[248.857144] Starting dynamic subtest: pipe-A-plane-2
[250.185670] Dynamic subtest pipe-A-plane-2: SUCCESS (1.338s)
[250.195877] Starting dynamic subtest: pipe-A-plane-3
[251.438811] Dynamic subtest pipe-A-plane-3: SUCCESS (1.249s)
[251.449292] Starting dynamic subtest: pipe-A-plane-4
[252.761921] Dynamic subtest pipe-A-plane-4: SUCCESS (1.323s)
[252.771452] Starting dynamic subtest: pipe-A-plane-5
[252.787221] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[253.979576] Starting dynamic subtest: pipe-B-plane-1
[255.235342] Dynamic subtest pipe-B-plane-1: SUCCESS (1.264s)
[255.245841] Starting dynamic subtest: pipe-B-plane-2
[256.588912] Dynamic subtest pipe-B-plane-2: SUCCESS (1.351s)
[256.599365] Starting dynamic subtest: pipe-B-plane-3
[257.931519] Dynamic subtest pipe-B-plane-3: SUCCESS (1.343s)
[257.941065] Starting dynamic subtest: pipe-B-plane-4
[259.248268] Dynamic subtest pipe-B-plane-4: SUCCESS (1.315s)
[259.259805] Starting dynamic subtest: pipe-B-plane-5
[259.282735] Dynamic subtest pipe-B-plane-5: SUCCESS (0.033s)
[259.285084] Subtest plane-position-covered: SUCCESS (12.229s)
[260.134045] [058/133] (760s left) kms_frontbuffer_tracking (psr-suspend)
[260.228455] Starting subtest: psr-suspend
[298.739030] Subtest psr-suspend: SUCCESS (8.193s)
[298.876607] [059/133] (721s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[298.988167] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[298.992726] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[299.102141] [060/133] (721s left) gem_exec_schedule (fairslice)
[299.181268] Starting subtest: fairslice
[299.183340] Starting dynamic subtest: rcs0
[301.225782] Dynamic subtest rcs0: SUCCESS (1.982s)
[301.238641] Starting dynamic subtest: bcs0
[303.247484] Dynamic subtest bcs0: SUCCESS (1.968s)
[303.258921] Starting dynamic subtest: vcs0
[305.268476] Dynamic subtest vcs0: SUCCESS (1.980s)
[305.280160] Starting dynamic subtest: vcs1
[307.291699] Dynamic subtest vcs1: SUCCESS (1.990s)
[307.302471] Starting dynamic subtest: vecs0
[309.310471] Dynamic subtest vecs0: SUCCESS (1.995s)
[309.322129] Starting dynamic subtest: ccs0
[311.329271] Dynamic subtest ccs0: SUCCESS (2.000s)
[311.331349] Subtest fairslice: SUCCESS (11.921s)
[311.642313] [061/133] (709s left) sw_sync (alloc_fence_invalid_timeline)
[311.688666] Starting subtest: alloc_fence_invalid_timeline
[311.691031] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[311.751585] [062/133] (708s left) gem_exec_whisper (basic-fds-forked)
[311.829828] Starting subtest: basic-fds-forked
[335.962787] Subtest basic-fds-forked: SUCCESS (24.075s)
[336.156660] [063/133] (684s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[336.266435] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[336.270396] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[336.356539] [064/133] (684s left) gem_vm_create (execbuf)
[336.407991] Starting subtest: execbuf
[336.414988] Subtest execbuf: SUCCESS (0.007s)
[336.561950] [065/133] (684s left) kms_cursor_crc (cursor-onscreen-256x85)
[336.819172] Starting subtest: cursor-onscreen-256x85
[336.865219] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[337.048260] [066/133] (683s left) kms_plane_alpha_blend (coverage-7efc)
[337.138860] Starting subtest: coverage-7efc
[337.438639] Starting dynamic subtest: pipe-A-eDP-1
[338.007813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[338.035103] Starting dynamic subtest: pipe-D-eDP-1
[339.361243] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[339.363937] Subtest coverage-7efc: SUCCESS (2.224s)
[340.202811] [067/133] (680s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[340.296649] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[340.299056] Starting dynamic subtest: pipe-A
[340.317510] Dynamic subtest pipe-A: SKIP (0.018s)
[340.328100] Starting dynamic subtest: pipe-B
[340.349078] Dynamic subtest pipe-B: SKIP (0.031s)
[340.359114] Starting dynamic subtest: pipe-C
[340.381838] Dynamic subtest pipe-C: SKIP (0.031s)
[340.391795] Starting dynamic subtest: pipe-D
[340.412192] Dynamic subtest pipe-D: SKIP (0.031s)
[340.416566] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.113s)
[340.514180] [068/133] (680s left) vgem_basic (busy-fence)
[340.564058] Starting subtest: busy-fence
[340.566330] Subtest busy-fence: SUCCESS (0.000s)
[340.625140] [069/133] (680s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[340.714458] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[340.743146] Starting dynamic subtest: pipe-A-plane-0
[341.176021] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[341.187175] Starting dynamic subtest: pipe-A-plane-3
[341.453614] Dynamic subtest pipe-A-plane-3: SUCCESS (0.277s)
[341.463144] Starting dynamic subtest: pipe-A-plane-5
[341.466711] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[342.593996] Starting dynamic subtest: pipe-B-plane-0
[343.031638] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[343.042227] Starting dynamic subtest: pipe-B-plane-3
[343.307186] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s)
[343.317554] Starting dynamic subtest: pipe-B-plane-5
[343.323732] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[343.617544] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.903s)
[344.487100] [070/133] (676s left) kms_addfb_basic (invalid-set-prop-any)
[344.541900] Starting subtest: invalid-set-prop-any
[344.544266] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[344.685520] [071/133] (676s left) kms_addfb_basic (size-max)
[344.786536] Starting subtest: size-max
[344.788712] Subtest size-max: SUCCESS (0.000s)
[344.870173] [072/133] (676s left) kms_addfb_basic (bad-pitch-128)
[344.922589] Starting subtest: bad-pitch-128
[344.925114] Subtest bad-pitch-128: SUCCESS (0.000s)
[345.071325] [073/133] (676s left) syncobj_timeline (single-wait-available-submitted)
[345.126144] Starting subtest: single-wait-available-submitted
[345.128468] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[345.232345] [074/133] (675s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[345.341773] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[346.381117] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.038s)
[346.500001] [075/133] (674s left) gem_pread (exhaustion)
[346.552459] Subtest exhaustion: SKIP (0.000s)
[346.615142] [076/133] (674s left) kms_frontbuffer_tracking (psr-1p-rte)
[346.716700] Starting subtest: psr-1p-rte
[352.071689] Subtest psr-1p-rte: SUCCESS (5.356s)
[352.227628] [077/133] (669s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[352.361523] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[370.270676] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.901s)
[371.088485] [078/133] (650s left) api_intel_allocator (fork-simple-once)
[371.158712] Starting subtest: fork-simple-once
[371.171695] Subtest fork-simple-once: SUCCESS (0.015s)
[371.290706] [079/133] (650s left) gem_set_tiling_vs_pwrite
[371.406903] [080/133] (650s left) kms_pm_backlight (brightness-with-dpms)
[371.509362] Starting subtest: brightness-with-dpms
[371.557792] Starting dynamic subtest: eDP-1
[373.990813] Dynamic subtest eDP-1: SUCCESS (2.429s)
[373.993235] Subtest brightness-with-dpms: SUCCESS (2.480s)
[374.842984] [081/133] (646s left) kms_lease (lease-invalid-crtc)
[374.939377] Starting subtest: lease-invalid-crtc
[374.941672] Starting dynamic subtest: pipe-A-eDP-1
[374.943993] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[374.953856] Starting dynamic subtest: pipe-B-eDP-1
[374.956195] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[374.966144] Starting dynamic subtest: pipe-C-eDP-1
[374.968477] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[374.977857] Starting dynamic subtest: pipe-D-eDP-1
[374.979785] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[374.981719] Subtest lease-invalid-crtc: SUCCESS (0.005s)
[375.020132] [082/133] (646s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[375.114108] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[375.118490] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[375.218071] [083/133] (646s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[375.321684] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[382.288924] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.966s)
[382.414817] [084/133] (639s left) kms_dp_linktrain_fallback (dp-fallback)
[382.517475] Starting subtest: dp-fallback
[382.523456] Subtest dp-fallback: SKIP (0.000s)
[382.593703] [085/133] (639s left) kms_vblank (ts-continuation-idle)
[382.678951] Starting subtest: ts-continuation-idle
[382.680801] Starting dynamic subtest: pipe-A-eDP-1
[383.076748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[383.092426] Starting dynamic subtest: pipe-D-eDP-1
[384.176915] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s)
[384.179299] Subtest ts-continuation-idle: SUCCESS (1.499s)
[385.052522] [086/133] (636s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[385.146243] Starting subtest: fbc-psr-cursor-mmap-gtt
[385.148515] Starting dynamic subtest: eDP-1
[385.152758] Dynamic subtest eDP-1: SKIP (0.000s)
[385.156904] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[385.223374] [087/133] (636s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[385.349129] Starting subtest: cursor-vs-flip-varying-size
[416.740716] Subtest cursor-vs-flip-varying-size: SUCCESS (31.395s)
[417.598692] [088/133] (604s left) i915_drm_fdinfo (busy-check-all)
[417.641454] Starting subtest: busy-check-all
[417.643813] Starting dynamic subtest: rcs0
[417.648259] Dynamic subtest rcs0: SKIP (0.003s)
[417.663927] Starting dynamic subtest: bcs0
[417.668154] Dynamic subtest bcs0: SKIP (0.000s)
[417.678280] Starting dynamic subtest: vcs0
[417.682440] Dynamic subtest vcs0: SKIP (0.000s)
[417.692699] Starting dynamic subtest: vcs1
[417.697300] Dynamic subtest vcs1: SKIP (0.000s)
[417.709967] Starting dynamic subtest: vecs0
[417.714337] Dynamic subtest vecs0: SKIP (0.000s)
[417.724339] Starting dynamic subtest: ccs0
[417.728695] Dynamic subtest ccs0: SKIP (0.000s)
[417.733105] Subtest busy-check-all: SKIP (0.008s)
[417.775608] [089/133] (604s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[417.884397] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[417.886695] Starting dynamic subtest: pipe-A-eDP-1
[417.906948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[417.918764] Starting dynamic subtest: pipe-B-eDP-1
[417.937837] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[417.947397] Starting dynamic subtest: pipe-C-eDP-1
[417.966771] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[417.976275] Starting dynamic subtest: pipe-D-eDP-1
[417.995538] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[417.997423] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[420.136631] [090/133] (601s left) prime_busy (before-wait)
[420.190673] Starting subtest: before-wait
[420.195869] Starting dynamic subtest: rcs0
[420.224273] Dynamic subtest rcs0: SUCCESS (0.030s)
[420.235182] Starting dynamic subtest: bcs0
[420.263814] Dynamic subtest bcs0: SUCCESS (0.039s)
[420.273531] Starting dynamic subtest: vcs0
[420.306257] Dynamic subtest vcs0: SUCCESS (0.041s)
[420.316326] Starting dynamic subtest: vcs1
[420.346421] Dynamic subtest vcs1: SUCCESS (0.039s)
[420.356443] Starting dynamic subtest: vecs0
[420.387503] Dynamic subtest vecs0: SUCCESS (0.040s)
[420.397472] Starting dynamic subtest: ccs0
[420.427931] Dynamic subtest ccs0: SUCCESS (0.040s)
[420.536575] Subtest before-wait: SUCCESS (0.344s)
[420.617791] [091/133] (601s left) gem_ppgtt (blt-vs-render-ctx0)
[420.680518] Starting subtest: blt-vs-render-ctx0
[453.429535] Subtest blt-vs-render-ctx0: SUCCESS (32.745s)
[453.579066] [092/133] (568s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[453.744404] Starting subtest: cursorB-vs-flipB-atomic
[453.748807] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[453.894520] [093/133] (568s left) gem_exec_reloc (basic-wc-read-active)
[453.959192] Subtest basic-wc-read-active: SKIP (0.000s)
[454.024226] [094/133] (568s left) gem_exec_fence (syncobj-import)
[454.502392] Starting subtest: syncobj-import
[454.508449] Subtest syncobj-import: SUCCESS (0.005s)
[456.209255] [095/133] (565s left) kms_psr (fbc-psr2-sprite-blt)
[456.298334] Starting subtest: fbc-psr2-sprite-blt
[456.300579] Starting dynamic subtest: eDP-1
[456.304530] Dynamic subtest eDP-1: SKIP (0.000s)
[456.308579] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[456.375885] [096/133] (565s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[456.470609] Starting subtest: plane-lut1d-post-ctm3x4
[456.651052] Starting dynamic subtest: pipe-A-plane-0
[456.817750] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[456.828534] Starting dynamic subtest: pipe-A-plane-1
[456.963080] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[456.973493] Starting dynamic subtest: pipe-A-plane-2
[457.116735] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[458.331843] Starting dynamic subtest: pipe-B-plane-0
[458.500940] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[458.515494] Starting dynamic subtest: pipe-B-plane-1
[458.678347] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[458.690353] Starting dynamic subtest: pipe-B-plane-2
[458.867569] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[460.060456] Starting dynamic subtest: pipe-C-plane-0
[460.193458] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[460.205915] Starting dynamic subtest: pipe-C-plane-1
[460.348974] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[460.360390] Starting dynamic subtest: pipe-C-plane-2
[460.504516] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[461.700893] Starting dynamic subtest: pipe-D-plane-0
[461.836268] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[461.847010] Starting dynamic subtest: pipe-D-plane-1
[461.992088] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[462.003107] Starting dynamic subtest: pipe-D-plane-2
[462.136676] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[462.427673] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.958s)
[463.274551] [097/133] (558s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[463.339400] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[463.343953] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[463.528122] [098/133] (558s left) kms_big_fb (linear-8bpp-rotate-180)
[463.633488] Starting subtest: linear-8bpp-rotate-180
[464.882978] Subtest linear-8bpp-rotate-180: SUCCESS (1.249s)
[465.021463] [099/133] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[465.124611] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[465.128288] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[465.220086] [100/133] (557s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[465.326172] Starting subtest: extended-modeset-hang-oldfb-with-reset
[465.328085] Starting dynamic subtest: pipe-A
[477.159272] Dynamic subtest pipe-A: SUCCESS (11.826s)
[477.170608] Starting dynamic subtest: pipe-D
[489.440252] Dynamic subtest pipe-D: SUCCESS (12.277s)
[489.442717] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.108s)
[490.242066] [101/133] (532s left) gem_exec_schedule (timeslicing)
[490.320900] Starting subtest: timeslicing
[490.322889] Starting dynamic subtest: rcs0
[490.331796] Dynamic subtest rcs0: SUCCESS (0.022s)
[490.345240] Starting dynamic subtest: bcs0
[490.352424] Dynamic subtest bcs0: SUCCESS (0.020s)
[490.362483] Starting dynamic subtest: vcs0
[490.374134] Dynamic subtest vcs0: SUCCESS (0.021s)
[490.388761] Starting dynamic subtest: vcs1
[490.399307] Dynamic subtest vcs1: SUCCESS (0.023s)
[490.411234] Starting dynamic subtest: vecs0
[490.423031] Dynamic subtest vecs0: SUCCESS (0.021s)
[490.437232] Starting dynamic subtest: ccs0
[490.445268] Dynamic subtest ccs0: SUCCESS (0.020s)
[490.447543] Subtest timeslicing: SUCCESS (0.136s)
[492.232398] [102/133] (530s left) kms_chamelium_color (ctm-0-25)
[492.336464] Subtest ctm-0-25: SKIP (0.000s)
[492.386171] [103/133] (530s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[492.480009] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[492.482235] Starting dynamic subtest: pipe-A-eDP-1
[492.578263] Dynamic subtest pipe-A-eDP-1: SKIP (0.102s)
[492.590239] Starting dynamic subtest: pipe-B-eDP-1
[493.718504] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[493.723246] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.243s)
[494.902627] [104/133] (527s left) gem_mmap (short-mmap)
[494.969643] Subtest short-mmap: SKIP (0.000s)
[495.036174] [105/133] (527s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[495.084630] Starting subtest: multi-wait-available-unsubmitted-submitted
[495.086997] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[495.198659] [106/133] (527s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[495.299732] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[495.303816] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[495.401680] [107/133] (527s left) kms_getfb (getfb2-accept-nv12)
[495.499306] Starting subtest: getfb2-accept-nv12
[495.501599] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[495.652369] [108/133] (527s left) syncobj_timeline (invalid-signal-zero-handles)
[495.710966] Starting subtest: invalid-signal-zero-handles
[495.713265] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[495.795133] [109/133] (526s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[495.880913] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[495.884613] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[495.990754] [110/133] (526s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[496.095429] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[496.097355] Starting dynamic subtest: pipe-A-eDP-1
[496.144642] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[496.155022] Starting dynamic subtest: pipe-B-eDP-1
[496.200255] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[496.211093] Starting dynamic subtest: pipe-C-eDP-1
[496.259929] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[496.271618] Starting dynamic subtest: pipe-D-eDP-1
[496.318841] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[496.322417] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[498.370979] [111/133] (524s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[498.457622] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[498.469404] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[498.553720] [112/133] (524s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[498.650256] Starting subtest: async-flip-with-page-flip-events-tiled
[499.027591] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[501.826287] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[501.839513] Starting dynamic subtest: pipe-A-eDP-1-4
[504.014128] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[504.027631] Starting dynamic subtest: pipe-A-eDP-1-4
[506.024149] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s)
[506.038273] Starting dynamic subtest: pipe-A-eDP-1-x
[508.202897] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[508.584137] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[511.360665] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.784s)
[511.371960] Starting dynamic subtest: pipe-B-eDP-1-4
[513.547151] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[513.558158] Starting dynamic subtest: pipe-B-eDP-1-4
[515.557412] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[515.568954] Starting dynamic subtest: pipe-B-eDP-1-x
[517.748306] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[518.115303] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[520.883961] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[520.894913] Starting dynamic subtest: pipe-C-eDP-1-4
[523.059145] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[523.070489] Starting dynamic subtest: pipe-C-eDP-1-4
[525.069581] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[525.082442] Starting dynamic subtest: pipe-C-eDP-1-x
[527.247934] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[527.615765] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[530.420592] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.814s)
[530.433016] Starting dynamic subtest: pipe-D-eDP-1-4
[532.592801] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.172s)
[532.603767] Starting dynamic subtest: pipe-D-eDP-1-4
[534.602487] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[534.613475] Starting dynamic subtest: pipe-D-eDP-1-x
[536.780346] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[536.782681] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.127s)
[538.012456] [113/133] (484s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[538.116112] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[538.120551] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[538.216128] [114/133] (484s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[538.269172] Starting subtest: etime-multi-wait-for-submit-submitted
[538.371338] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[538.451461] [115/133] (484s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[540.283272] Starting subtest: modeset-non-lpsp-stress-no-wait
[540.335479] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.052s)
[540.752573] [116/133] (482s left) gem_exec_params (sol-reset-invalid)
[540.824275] Starting subtest: sol-reset-invalid
[540.826669] Subtest sol-reset-invalid: SUCCESS (0.002s)
[542.212664] [117/133] (480s left) gem_mmap_gtt (cpuset-big-copy)
[542.282023] Subtest cpuset-big-copy: SKIP (0.000s)
[542.346128] [118/133] (480s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[542.445532] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[550.101025] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.661s)
[550.217262] [119/133] (472s left) kms_psr (psr2-sprite-plane-onoff)
[550.331405] Starting subtest: psr2-sprite-plane-onoff
[550.333704] Starting dynamic subtest: eDP-1
[552.080683] Dynamic subtest eDP-1: SUCCESS (1.749s)
[552.082980] Subtest psr2-sprite-plane-onoff: SUCCESS (1.750s)
[552.924679] [120/133] (470s left) kms_dsc (dsc-with-output-formats)
[553.019657] Starting subtest: dsc-with-output-formats
[553.041434] Subtest dsc-with-output-formats: SKIP (0.001s)
[553.096641] [121/133] (470s left) gen3_mixed_blits
[553.219602] [122/133] (470s left) gem_mmap_offset (clear-via-pagefault)
[553.273336] Starting subtest: clear-via-pagefault
[553.275721] Starting dynamic subtest: smem0
[589.231430] Dynamic subtest smem0: SUCCESS (35.955s)
[589.234108] Subtest clear-via-pagefault: SUCCESS (35.956s)
[589.349602] [123/133] (434s left) gem_eio (reset-stress)
[589.589997] Starting subtest: reset-stress
[589.592401] Starting dynamic subtest: render
[594.783828] Dynamic subtest render: SUCCESS (5.190s)
[594.802447] Starting dynamic subtest: bsd1
[612.724188] Dynamic subtest bsd1: SUCCESS (17.936s)
[612.743311] Starting dynamic subtest: bsd2
[630.667599] Dynamic subtest bsd2: SUCCESS (17.940s)
[630.684387] Starting dynamic subtest: blt
[630.688639] Dynamic subtest blt: SKIP (0.000s)
[630.698246] Starting dynamic subtest: vebox
[648.666527] Dynamic subtest vebox: SUCCESS (17.995s)
[648.668539] Subtest reset-stress: SUCCESS (59.066s)
[650.227971] [124/133] (373s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[650.292009] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[650.294427] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[650.390648] [125/133] (373s left) kms_vblank (query-busy-hang)
[650.479505] Starting subtest: query-busy-hang
[650.481624] Starting dynamic subtest: pipe-A-eDP-1
[652.367616] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s)
[652.382986] Starting dynamic subtest: pipe-D-eDP-1
[654.968379] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.596s)
[654.970768] Subtest query-busy-hang: SUCCESS (4.491s)
[655.770907] [126/133] (367s left) kms_psr (fbc-pr-cursor-plane-onoff)
[655.872749] Starting subtest: fbc-pr-cursor-plane-onoff
[655.876905] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[655.949511] [127/133] (367s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[656.061871] Starting subtest: psr-1p-primscrn-cur-indfb-move
[663.492974] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.433s)
[663.632874] [128/133] (359s left) tools_test (sysfs_l3_parity)
[663.690697] Starting subtest: sysfs_l3_parity
[663.762165] Subtest sysfs_l3_parity: SKIP (0.082s)
[663.817964] [129/133] (359s left) kms_vblank (crtc-id)
[663.907310] Starting subtest: crtc-id
[663.909411] Starting dynamic subtest: pipe-A-eDP-1
[664.347038] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[664.365681] Starting dynamic subtest: pipe-D-eDP-1
[665.444271] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.094s)
[665.446736] Subtest crtc-id: SUCCESS (1.539s)
[666.283888] [130/133] (357s left) gem_ctx_engines (independent)
[666.354125] Starting subtest: independent
[666.356383] Starting dynamic subtest: rcs0
[666.512544] Dynamic subtest rcs0: SUCCESS (0.160s)
[666.525776] Starting dynamic subtest: bcs0
[666.681564] Dynamic subtest bcs0: SUCCESS (0.169s)
[666.694777] Starting dynamic subtest: vcs0
[666.831789] Dynamic subtest vcs0: SUCCESS (0.149s)
[666.845352] Starting dynamic subtest: vcs1
[667.009167] Dynamic subtest vcs1: SUCCESS (0.177s)
[667.020716] Starting dynamic subtest: vecs0
[667.182172] Dynamic subtest vecs0: SUCCESS (0.171s)
[667.194738] Starting dynamic subtest: ccs0
[667.361791] Dynamic subtest ccs0: SUCCESS (0.179s)
[667.376311] Starting dynamic subtest: all-engines
[668.020188] Dynamic subtest all-engines: SUCCESS (0.658s)
[668.022384] Subtest independent: SUCCESS (1.669s)
[668.393701] [131/133] (355s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[668.495785] Starting subtest: flip-vs-dpms-on-nop-interruptible
[668.498145] Starting dynamic subtest: A-eDP1
[670.382877] Dynamic subtest A-eDP1: SUCCESS (1.885s)
[670.395702] Starting dynamic subtest: B-eDP1
[672.208121] Dynamic subtest B-eDP1: SUCCESS (1.822s)
[672.222356] Starting dynamic subtest: C-eDP1
[674.031457] Dynamic subtest C-eDP1: SUCCESS (1.820s)
[674.045001] Starting dynamic subtest: D-eDP1
[675.856887] Dynamic subtest D-eDP1: SUCCESS (1.823s)
[675.861742] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.364s)
[677.041476] [132/133] (346s left) kms_plane_lowres (tiling-x)
[677.141365] Starting subtest: tiling-x
[677.143567] Starting dynamic subtest: pipe-A-eDP-1
[677.147941] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[677.440020] Starting dynamic subtest: pipe-B-eDP-1
[677.444776] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[677.455727] Starting dynamic subtest: pipe-C-eDP-1
[677.460267] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[677.471058] Starting dynamic subtest: pipe-D-eDP-1
[677.474937] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[677.478951] Subtest tiling-x: SKIP (0.294s)
[678.280431] [133/133] (345s left) i915_pm_freq_api (freq-reset)
[678.353894] Starting subtest: freq-reset
[678.356562] Starting dynamic subtest: gt0
[678.548898] Dynamic subtest gt0: SUCCESS (0.192s)
[678.561216] Starting dynamic subtest: gt1
[678.725014] Dynamic subtest gt1: SUCCESS (0.175s)
[678.728133] Subtest freq-reset: SUCCESS (0.371s)
[678.811625] 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.