[60.356733] Initializing watchdogs
[60.356780]   /dev/watchdog0
[60.371245] [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.376093] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.378515] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.381991] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[60.501974] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[60.506173] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[60.591102] [002/133] (960s left) syncobj_timeline (wait-all-for-submit-snapshot)
[60.649826] Starting subtest: wait-all-for-submit-snapshot
[60.730055] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[60.802648] [003/133] (960s left) kms_getfb (getfb-handle-not-fb)
[60.898730] Starting subtest: getfb-handle-not-fb
[60.900656] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[61.000340] [004/133] (959s left) gem_exec_alignment (single)
[61.062056] Starting subtest: single
[61.067154] Subtest single: SUCCESS (0.005s)
[61.170931] [005/133] (959s left) gem_mmap_gtt (basic-small-copy-odd)
[61.242971] Subtest basic-small-copy-odd: SKIP (0.000s)
[61.308697] [006/133] (959s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[61.406601] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[61.410235] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[61.471649] [007/133] (959s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[61.523955] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[61.525954] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[61.613759] [008/133] (959s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[61.714605] Starting subtest: y-tiled-16bpp-rotate-270
[61.718435] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[61.810172] [009/133] (959s left) core_hotunplug (unbind-rebind)
[61.899229] Starting subtest: unbind-rebind
[67.791023] Subtest unbind-rebind: SUCCESS (5.890s)
[67.838180] [010/133] (953s left) kms_selftest (drm_format)
[67.896065] Starting subtest: drm_format
[67.902876] Starting dynamic subtest: drm_test_format_block_width_invalid
[68.101631] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.199s)
[68.115730] Starting dynamic subtest: drm_test_format_block_width_one_plane
[68.197571] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.095s)
[68.207154] Starting dynamic subtest: drm_test_format_block_width_two_plane
[68.294950] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.097s)
[68.302797] Starting dynamic subtest: drm_test_format_block_width_three_plane
[68.388535] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.092s)
[68.398790] Starting dynamic subtest: drm_test_format_block_width_tiled
[68.487526] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.100s)
[68.496436] Starting dynamic subtest: drm_test_format_block_height_invalid
[68.586415] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.098s)
[68.595444] Starting dynamic subtest: drm_test_format_block_height_one_plane
[68.686834] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.100s)
[68.696241] Starting dynamic subtest: drm_test_format_block_height_two_plane
[68.843082] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.133s)
[68.853472] Starting dynamic subtest: drm_test_format_block_height_three_plane
[68.936397] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.115s)
[68.944858] Starting dynamic subtest: drm_test_format_block_height_tiled
[69.035355] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.099s)
[69.042833] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[69.144185] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.109s)
[69.151556] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[69.247995] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.103s)
[69.256245] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[69.347280] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.098s)
[69.357252] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[69.450220] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.103s)
[69.457589] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[69.555917] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.105s)
[69.563326] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[69.647129] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.092s)
[69.654456] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[69.739070] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.092s)
[69.746593] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[69.833890] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.093s)
[69.836177] Subtest drm_format: SUCCESS (1.939s)
[69.972611] [011/133] (951s left) gem_exec_balancer (bonded-true-hang)
[70.237470] Starting subtest: bonded-true-hang
[70.242939] Subtest bonded-true-hang: SKIP (0.000s)
[70.322385] [012/133] (950s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[70.374717] Starting subtest: etime-multi-wait-available-unsubmitted
[70.484385] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.108s)
[70.557208] [013/133] (950s left) sw_sync (alloc_fence_invalid_timeline)
[70.591698] Starting subtest: alloc_fence_invalid_timeline
[70.593802] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[70.645473] [014/133] (950s left) kms_joiner (basic-big-joiner)
[70.753610] Starting subtest: basic-big-joiner
[70.758094] Subtest basic-big-joiner: SKIP (0.000s)
[70.818688] [015/133] (950s left) kms_flip (2x-plain-flip)
[70.915619] Starting subtest: 2x-plain-flip
[70.925041] Subtest 2x-plain-flip: SKIP (0.011s)
[71.006793] [016/133] (950s left) gem_exec_reloc (basic-gtt-cpu-active)
[71.068797] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[71.144934] [017/133] (950s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[71.208521] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[71.213251] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[71.401988] [018/133] (950s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[71.501479] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[71.505865] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[71.568810] [019/133] (950s left) kms_cursor_edge_walk (128x128-top-bottom)
[71.657889] Starting subtest: 128x128-top-bottom
[71.660285] Starting dynamic subtest: pipe-A-eDP-1
[75.166376] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s)
[75.176650] Starting dynamic subtest: pipe-D-eDP-1
[78.370673] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.203s)
[78.372873] Subtest 128x128-top-bottom: SUCCESS (6.713s)
[79.166629] [020/133] (942s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[81.109641] Starting subtest: modeset-lpsp-stress-no-wait
[90.726555] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.619s)
[90.817038] [021/133] (930s left) gem_mmap_offset (bad-extensions)
[90.888867] Starting subtest: bad-extensions
[90.891199] Subtest bad-extensions: SUCCESS (0.000s)
[90.982082] [022/133] (930s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[91.085504] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[91.090697] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[91.159172] [023/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[91.261468] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[91.266039] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[91.353434] [024/133] (930s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[91.436757] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[91.438961] Starting dynamic subtest: pipe-A
[92.486504] Dynamic subtest pipe-A: SUCCESS (1.051s)
[92.496615] Starting dynamic subtest: pipe-B
[94.588702] Dynamic subtest pipe-B: SUCCESS (2.098s)
[94.598449] Starting dynamic subtest: pipe-C
[95.798117] Dynamic subtest pipe-C: SUCCESS (1.212s)
[95.806101] Starting dynamic subtest: pipe-D
[97.015544] Dynamic subtest pipe-D: SUCCESS (1.216s)
[97.017875] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.580s)
[98.216252] [025/133] (923s left) syncobj_wait (single-wait-submitted)
[98.276777] Starting subtest: single-wait-submitted
[98.379973] Subtest single-wait-submitted: SUCCESS (0.101s)
[98.451775] [026/133] (923s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[98.545083] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[98.549564] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[98.624568] [027/133] (923s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[98.720052] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[102.882523] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.166s)
[104.032181] [028/133] (917s left) syncobj_wait (single-wait-for-submit-signaled)
[104.095264] Starting subtest: single-wait-for-submit-signaled
[104.097663] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[104.189873] [029/133] (917s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[104.313229] Starting subtest: cursorA-vs-flipA-atomic
[115.465525] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.151s)
[116.334161] [030/133] (905s left) gem_ctx_param (invalid-get-no-zeromap)
[116.383073] Starting subtest: invalid-get-no-zeromap
[116.385557] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[116.468877] [031/133] (905s left) gem_exec_create (madvise)
[116.526237] Starting subtest: madvise
[116.528490] Starting dynamic subtest: smem
[138.010421] Dynamic subtest smem: SUCCESS (21.482s)
[138.013230] Subtest madvise: SUCCESS (21.482s)
[139.273494] [032/133] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[139.378265] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[139.382253] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[139.485679] [033/133] (882s left) prime_vgem (sync)
[139.643607] Starting subtest: sync
[139.645919] Starting dynamic subtest: rcs0
[139.677409] Dynamic subtest rcs0: SUCCESS (0.034s)
[139.685547] Starting dynamic subtest: bcs0
[139.735644] Dynamic subtest bcs0: SUCCESS (0.058s)
[139.743915] Starting dynamic subtest: vcs0
[139.784780] Dynamic subtest vcs0: SUCCESS (0.049s)
[139.793139] Starting dynamic subtest: vcs1
[139.830635] Dynamic subtest vcs1: SUCCESS (0.045s)
[139.839161] Starting dynamic subtest: vecs0
[139.876731] Dynamic subtest vecs0: SUCCESS (0.045s)
[139.885280] Starting dynamic subtest: ccs0
[139.922629] Dynamic subtest ccs0: SUCCESS (0.046s)
[139.924922] Subtest sync: SUCCESS (0.279s)
[140.035159] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[140.038271] [034/133] (882s left) gem_exec_fence (basic-busy)
[140.219057] Starting subtest: basic-busy
[140.221759] Starting dynamic subtest: rcs0
[140.310932] Dynamic subtest rcs0: SUCCESS (0.092s)
[140.322242] Starting dynamic subtest: bcs0
[140.366795] Dynamic subtest bcs0: SUCCESS (0.055s)
[140.376750] Starting dynamic subtest: vcs0
[140.419072] Dynamic subtest vcs0: SUCCESS (0.051s)
[140.428906] Starting dynamic subtest: vcs1
[140.473544] Dynamic subtest vcs1: SUCCESS (0.053s)
[140.483891] Starting dynamic subtest: vecs0
[140.526581] Dynamic subtest vecs0: SUCCESS (0.052s)
[140.536114] Starting dynamic subtest: ccs0
[140.579680] Dynamic subtest ccs0: SUCCESS (0.052s)
[140.582073] Subtest basic-busy: SUCCESS (0.362s)
[141.991062] [035/133] (880s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[142.097095] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[147.381868] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.290s)
[148.550498] [036/133] (873s left) kms_big_fb (linear-addfb)
[148.654535] Starting subtest: linear-addfb
[148.656898] Subtest linear-addfb: SUCCESS (0.000s)
[148.755113] [037/133] (873s left) gem_vm_create (isolation)
[148.812794] Starting subtest: isolation
[148.822592] Subtest isolation: SUCCESS (0.010s)
[148.921377] [038/133] (873s left) gem_exec_params (invalid-fence-in-submit)
[148.970365] Starting subtest: invalid-fence-in-submit
[148.975587] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[149.081020] [039/133] (873s left) perf_pmu (invalid-open)
[149.120337] Starting subtest: invalid-open
[149.122729] Subtest invalid-open: SUCCESS (0.000s)
[149.234804] [040/133] (873s left) gem_busy (busy)
[149.298033] Starting subtest: busy
[149.300984] Starting dynamic subtest: all-engines
[149.370721] Dynamic subtest all-engines: SUCCESS (0.074s)
[149.379326] Starting dynamic subtest: rcs0
[150.879842] Dynamic subtest rcs0: SUCCESS (1.508s)
[150.890521] Starting dynamic subtest: bcs0
[150.930052] Dynamic subtest bcs0: SUCCESS (0.048s)
[150.940102] Starting dynamic subtest: vcs0
[150.967919] Dynamic subtest vcs0: SUCCESS (0.039s)
[150.976899] Starting dynamic subtest: vcs1
[152.925459] Dynamic subtest vcs1: SUCCESS (1.954s)
[152.935594] Starting dynamic subtest: vecs0
[154.910079] Dynamic subtest vecs0: SUCCESS (1.983s)
[154.920523] Starting dynamic subtest: ccs0
[156.893744] Dynamic subtest ccs0: SUCCESS (1.984s)
[156.896470] Subtest busy: SUCCESS (7.596s)
[157.271353] [041/133] (865s left) kms_draw_crc (draw-method-render)
[157.390868] Starting subtest: draw-method-render
[157.392769] Starting dynamic subtest: xrgb8888-untiled
[157.657517] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[157.666494] Starting dynamic subtest: rgb565-untiled
[157.879959] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[157.888625] Starting dynamic subtest: xrgb2101010-untiled
[158.113233] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[158.121784] Starting dynamic subtest: xbgr16161616f-untiled
[158.346359] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[158.355079] Starting dynamic subtest: xrgb8888-xtiled
[158.479807] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[158.488900] Starting dynamic subtest: rgb565-xtiled
[158.590719] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[158.599083] Starting dynamic subtest: xrgb2101010-xtiled
[158.713038] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[158.721749] Starting dynamic subtest: xbgr16161616f-xtiled
[158.835456] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[158.844122] Starting dynamic subtest: xrgb8888-4tiled
[158.969153] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[158.982694] Starting dynamic subtest: rgb565-4tiled
[159.101896] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[159.112537] Starting dynamic subtest: xrgb2101010-4tiled
[159.257290] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[159.267083] Starting dynamic subtest: xbgr16161616f-4tiled
[159.390781] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[159.392637] Subtest draw-method-render: SUCCESS (2.002s)
[159.493834] [042/133] (862s left) gem_exec_reloc (basic-cpu-active)
[159.544733] Subtest basic-cpu-active: SKIP (0.000s)
[159.612730] [043/133] (862s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[159.722060] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[166.278357] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.559s)
[166.395971] [044/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[166.495357] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[166.499488] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[166.583580] [045/133] (856s left) gem_softpin (softpin)
[166.643960] Starting subtest: softpin
[199.003117] Subtest softpin: SUCCESS (32.357s)
[199.109042] [046/133] (823s left) gem_pxp (create-regular-context-1)
[199.229876] Starting subtest: create-regular-context-1
[199.232449] Subtest create-regular-context-1: SUCCESS (0.002s)
[199.371230] [047/133] (823s left) kms_dp_link_training (non-uhbr-mst)
[199.472726] Starting subtest: non-uhbr-mst
[199.481019] Subtest non-uhbr-mst: SKIP (0.000s)
[199.545255] [048/133] (823s left) gem_exec_fence (syncobj-timeline-chain-engines)
[200.102648] Starting subtest: syncobj-timeline-chain-engines
[200.212194] Subtest syncobj-timeline-chain-engines: SUCCESS (0.110s)
[201.941199] [049/133] (820s left) kms_async_flips (crc-atomic)
[202.031959] Starting subtest: crc-atomic
[202.420370] Starting dynamic subtest: pipe-A-eDP-1
[205.297764] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.877s)
[205.674028] Starting dynamic subtest: pipe-B-eDP-1
[208.636304] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.970s)
[209.022424] Starting dynamic subtest: pipe-C-eDP-1
[211.951224] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.938s)
[212.311933] Starting dynamic subtest: pipe-D-eDP-1
[215.173974] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.871s)
[215.176318] Subtest crc-atomic: SUCCESS (13.143s)
[216.346288] [050/133] (806s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[216.447827] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[217.094351] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s)
[217.268049] [051/133] (805s left) gen9_exec_parse (allowed-all)
[217.322361] Subtest allowed-all: SKIP (0.000s)
[217.401427] [052/133] (805s left) kms_legacy_colorkey (invalid-plane)
[217.486142] Starting subtest: invalid-plane
[217.488450] Starting dynamic subtest: zero-id
[217.490365] Dynamic subtest zero-id: SUCCESS (0.000s)
[217.501739] Starting dynamic subtest: outrange-id
[217.503982] Dynamic subtest outrange-id: SUCCESS (0.000s)
[217.506225] Subtest invalid-plane: SUCCESS (0.001s)
[217.576375] [053/133] (805s left) kms_psr (fbc-psr2-primary-blt)
[217.679432] Starting subtest: fbc-psr2-primary-blt
[217.681701] Starting dynamic subtest: eDP-1
[217.686189] Dynamic subtest eDP-1: SKIP (0.000s)
[217.690699] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[217.763385] [054/133] (805s left) gem_exec_create (basic)
[217.825560] Starting subtest: basic
[217.827814] Starting dynamic subtest: smem
[221.849485] Dynamic subtest smem: SUCCESS (4.021s)
[221.852385] Subtest basic: SUCCESS (4.023s)
[222.031986] [055/133] (801s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[222.087939] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[222.090215] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[222.191678] [056/133] (800s left) kms_getfb (getfb-handle-protection)
[222.289881] Starting subtest: getfb-handle-protection
[222.312308] Subtest getfb-handle-protection: SUCCESS (0.023s)
[222.455702] [057/133] (800s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[222.541186] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[222.543475] Starting dynamic subtest: pipe-A-eDP-1
[222.566689] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[222.577947] Starting dynamic subtest: pipe-B-eDP-1
[222.599832] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[222.608525] Starting dynamic subtest: pipe-C-eDP-1
[222.630602] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[222.640057] Starting dynamic subtest: pipe-D-eDP-1
[222.662200] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[222.666253] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[224.799479] [058/133] (798s left) kms_vblank (wait-busy)
[224.897233] Starting subtest: wait-busy
[224.899114] Starting dynamic subtest: pipe-A-eDP-1
[226.776598] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[226.791237] Starting dynamic subtest: pipe-D-eDP-1
[229.349076] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[229.351243] Subtest wait-busy: SUCCESS (4.451s)
[230.146236] [059/133] (793s left) i915_hangman (engine-error-state-capture)
[230.221508] Starting subtest: engine-error-state-capture
[230.223960] Starting dynamic subtest: rcs0
[233.854677] Dynamic subtest rcs0: SUCCESS (3.624s)
[233.864151] Starting dynamic subtest: bcs0
[239.864049] Dynamic subtest bcs0: SUCCESS (6.017s)
[239.875671] Starting dynamic subtest: vcs0
[245.877847] Dynamic subtest vcs0: SUCCESS (6.011s)
[245.889825] Starting dynamic subtest: vcs1
[251.893350] Dynamic subtest vcs1: SUCCESS (6.013s)
[251.904806] Starting dynamic subtest: vecs0
[257.909832] Dynamic subtest vecs0: SUCCESS (6.014s)
[257.932538] Starting dynamic subtest: ccs0
[263.861346] Dynamic subtest ccs0: SUCCESS (5.949s)
[263.866183] Subtest engine-error-state-capture: SUCCESS (33.640s)
[263.940713] [060/133] (759s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[263.998080] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[264.100471] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[264.177591] [061/133] (759s left) gem_create (create-clear)
[264.229912] Starting subtest: create-clear
[264.232098] Starting dynamic subtest: smem0
[297.050743] Dynamic subtest smem0: SUCCESS (32.817s)
[297.053201] Subtest create-clear: SUCCESS (32.819s)
[297.241764] [062/133] (726s left) gem_exec_schedule (smoketest)
[297.425418] Starting subtest: smoketest
[297.428032] Starting dynamic subtest: rcs0
[302.980495] Dynamic subtest rcs0: SUCCESS (5.507s)
[302.995648] Starting dynamic subtest: bcs0
[308.473237] Dynamic subtest bcs0: SUCCESS (5.488s)
[308.488381] Starting dynamic subtest: vcs0
[313.965297] Dynamic subtest vcs0: SUCCESS (5.493s)
[313.977101] Starting dynamic subtest: vcs1
[319.474210] Dynamic subtest vcs1: SUCCESS (5.507s)
[319.486737] Starting dynamic subtest: vecs0
[324.980411] Dynamic subtest vecs0: SUCCESS (5.506s)
[324.991070] Starting dynamic subtest: ccs0
[330.478971] Dynamic subtest ccs0: SUCCESS (5.498s)
[330.481071] Subtest smoketest: SUCCESS (33.004s)
[330.621172] [063/133] (692s left) kms_big_fb (yf-tiled-addfb)
[330.740394] Starting subtest: yf-tiled-addfb
[330.744945] Subtest yf-tiled-addfb: SKIP (0.000s)
[330.839571] [064/133] (692s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[330.939467] Starting subtest: psr-rgb101010-draw-mmap-gtt
[330.943855] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[331.035150] [065/133] (692s left) kms_panel_fitting (legacy)
[331.123149] Starting subtest: legacy
[331.125483] Starting dynamic subtest: pipe-A-eDP-1
[331.666050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[331.691068] Starting dynamic subtest: pipe-B-eDP-1
[333.252975] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.569s)
[333.279324] Starting dynamic subtest: pipe-C-eDP-1
[334.829597] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.555s)
[334.853679] Starting dynamic subtest: pipe-D-eDP-1
[336.338921] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.492s)
[336.341152] Subtest legacy: SUCCESS (5.219s)
[337.586424] [066/133] (685s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[337.694390] Starting subtest: random-ccs-data-y-tiled-ccs
[337.696749] Starting dynamic subtest: pipe-A-eDP-1
[337.722075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[337.733189] Starting dynamic subtest: pipe-B-eDP-1
[337.756702] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[337.764722] Starting dynamic subtest: pipe-C-eDP-1
[337.788500] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[337.796508] Starting dynamic subtest: pipe-D-eDP-1
[337.820280] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[337.824604] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[339.860120] [067/133] (683s left) perf (create-destroy-userspace-config)
[339.990277] Starting subtest: create-destroy-userspace-config
[340.010083] Subtest create-destroy-userspace-config: SUCCESS (0.019s)
[340.057883] [068/133] (683s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[340.121066] Starting subtest: yf-tiled-ccs-to-yf-tiled
[340.125384] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[340.304479] [069/133] (683s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[340.404264] Starting subtest: blocking-absolute-wf_vblank-interruptible
[340.406600] Starting dynamic subtest: A-eDP1
[349.126025] Dynamic subtest A-eDP1: SUCCESS (8.719s)
[349.134968] Starting dynamic subtest: B-eDP1
[357.858608] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[357.870694] Starting dynamic subtest: C-eDP1
[366.572151] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[366.584166] Starting dynamic subtest: D-eDP1
[375.301231] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[375.306655] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.900s)
[376.515591] [070/133] (647s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[376.618022] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[376.620491] Starting dynamic subtest: pipe-A-eDP-1
[382.512881] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.898s)
[382.522327] Starting dynamic subtest: pipe-B-eDP-1
[389.134686] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.616s)
[389.137042] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.518s)
[390.002854] [071/133] (633s left) api_intel_bb (delta-check)
[390.066534] Starting subtest: delta-check
[390.071727] Subtest delta-check: SUCCESS (0.006s)
[390.194810] [072/133] (633s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[390.288730] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[390.292804] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[390.391800] [073/133] (633s left) gem_ctx_sseu (invalid-sseu)
[390.458182] Subtest invalid-sseu: SKIP (0.000s)
[390.536602] [074/133] (633s left) gem_exec_flush (basic-wb-rw-before-default)
[390.594842] Starting subtest: basic-wb-rw-before-default
[396.052381] Subtest basic-wb-rw-before-default: SUCCESS (5.457s)
[396.239749] [075/133] (627s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[396.374805] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[397.169541] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.797s)
[397.372071] [076/133] (626s left) kms_vblank (crtc-id)
[397.481794] Starting subtest: crtc-id
[397.483593] Starting dynamic subtest: pipe-A-eDP-1
[397.939822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s)
[397.954996] Starting dynamic subtest: pipe-D-eDP-1
[399.035649] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.094s)
[399.037990] Subtest crtc-id: SUCCESS (1.554s)
[399.868793] [077/133] (624s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[399.966650] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[399.971096] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[400.064484] [078/133] (623s left) kms_psr (fbc-psr-primary-mmap-cpu)
[400.162237] Starting subtest: fbc-psr-primary-mmap-cpu
[400.164527] Starting dynamic subtest: eDP-1
[400.168643] Dynamic subtest eDP-1: SKIP (0.000s)
[400.172774] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[400.233167] [079/133] (623s left) kms_content_protection (dp-mst-lic-type-0)
[400.372434] Starting subtest: dp-mst-lic-type-0
[400.376969] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[400.484588] [080/133] (623s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[400.575686] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[400.580174] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[400.678048] [081/133] (623s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[400.783919] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[400.786792] Starting dynamic subtest: pipe-A-default-mode
[401.927214] Dynamic subtest pipe-A-default-mode: SKIP (1.143s)
[401.931901] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.145s)
[402.085445] [082/133] (622s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[402.196788] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[402.330843] [083/133] (621s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[402.435401] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[402.437860] Starting dynamic subtest: pipe-A-eDP-1
[402.580882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[402.595470] Starting dynamic subtest: pipe-B-eDP-1
[402.615212] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[402.625082] Starting dynamic subtest: pipe-C-eDP-1
[402.644340] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[402.652479] Starting dynamic subtest: pipe-D-eDP-1
[402.671424] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[402.673304] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[404.880113] [084/133] (619s left) gem_exec_schedule (in-order)
[404.948580] Starting subtest: in-order
[404.950922] Starting dynamic subtest: rcs0
[405.047318] Dynamic subtest rcs0: SUCCESS (0.107s)
[405.058664] Starting dynamic subtest: vcs0
[405.138284] Dynamic subtest vcs0: SUCCESS (0.090s)
[405.148907] Starting dynamic subtest: vcs1
[405.220504] Dynamic subtest vcs1: SUCCESS (0.081s)
[405.237397] Starting dynamic subtest: vecs0
[405.305713] Dynamic subtest vecs0: SUCCESS (0.081s)
[405.315073] Starting dynamic subtest: ccs0
[405.396997] Dynamic subtest ccs0: SUCCESS (0.092s)
[405.399987] Subtest in-order: SUCCESS (0.458s)
[407.029179] [085/133] (617s left) i915_drm_fdinfo (busy-idle-check-all)
[407.072479] Starting subtest: busy-idle-check-all
[407.074687] Starting dynamic subtest: rcs0
[407.080058] Dynamic subtest rcs0: SKIP (0.004s)
[407.091305] Starting dynamic subtest: bcs0
[407.095889] Dynamic subtest bcs0: SKIP (0.000s)
[407.105729] Starting dynamic subtest: vcs0
[407.110300] Dynamic subtest vcs0: SKIP (0.000s)
[407.119776] Starting dynamic subtest: vcs1
[407.123944] Dynamic subtest vcs1: SKIP (0.000s)
[407.132100] Starting dynamic subtest: vecs0
[407.136216] Dynamic subtest vecs0: SKIP (0.000s)
[407.144254] Starting dynamic subtest: ccs0
[407.148263] Dynamic subtest ccs0: SKIP (0.000s)
[407.152286] Subtest busy-idle-check-all: SKIP (0.011s)
[407.189756] [086/133] (617s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[407.279362] Starting subtest: nonblocking-crc-frame-sequence
[407.281618] Starting dynamic subtest: pipe-A-eDP-1
[408.036910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s)
[408.050380] Starting dynamic subtest: pipe-B-eDP-1
[409.508671] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.470s)
[409.518268] Starting dynamic subtest: pipe-C-eDP-1
[410.865774] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.357s)
[410.875499] Starting dynamic subtest: pipe-D-eDP-1
[412.203649] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[412.206101] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.926s)
[412.991298] [087/133] (611s left) vgem_basic (setversion)
[413.043808] Starting subtest: setversion
[413.048448] Subtest setversion: SUCCESS (0.000s)
[413.100622] [088/133] (611s left) gem_eio (wait-wedge-1us)
[413.338411] Starting subtest: wait-wedge-1us
[415.013450] Subtest wait-wedge-1us: SUCCESS (1.674s)
[415.161409] [089/133] (609s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[415.269343] Starting subtest: 2x-flip-vs-cursor-legacy
[415.273774] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[415.418140] [090/133] (609s left) kms_psr (fbc-psr-sprite-render)
[415.511080] Starting subtest: fbc-psr-sprite-render
[415.513338] Starting dynamic subtest: eDP-1
[415.517600] Dynamic subtest eDP-1: SKIP (0.000s)
[415.521736] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[415.606070] [091/133] (608s left) i915_pm_rpm (gem-execbuf)
[417.133089] Starting subtest: gem-execbuf
[417.136039] Starting dynamic subtest: smem0
[419.315912] Dynamic subtest smem0: SUCCESS (2.181s)
[419.318776] Subtest gem-execbuf: SUCCESS (2.183s)
[419.408627] [092/133] (605s left) api_intel_allocator (fork-simple-once)
[419.474009] Starting subtest: fork-simple-once
[419.488057] Subtest fork-simple-once: SUCCESS (0.016s)
[419.595483] [093/133] (605s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[419.686695] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[419.690998] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[419.777292] [094/133] (604s left) gem_userptr_blits (unsync-unmap)
[419.843994] Subtest unsync-unmap: SKIP (0.000s)
[419.969612] [095/133] (604s left) perf_pmu (busy-accuracy-2)
[420.009167] Starting subtest: busy-accuracy-2
[420.011380] Starting dynamic subtest: rcs0
[423.055918] Dynamic subtest rcs0: SUCCESS (3.044s)
[423.067877] Starting dynamic subtest: bcs0
[426.117952] Dynamic subtest bcs0: SUCCESS (3.059s)
[426.129883] Starting dynamic subtest: vcs0
[429.163947] Dynamic subtest vcs0: SUCCESS (3.045s)
[429.174092] Starting dynamic subtest: vcs1
[432.211170] Dynamic subtest vcs1: SUCCESS (3.045s)
[432.220588] Starting dynamic subtest: vecs0
[435.257388] Dynamic subtest vecs0: SUCCESS (3.044s)
[435.267099] Starting dynamic subtest: ccs0
[438.315116] Dynamic subtest ccs0: SUCCESS (3.055s)
[438.317537] Subtest busy-accuracy-2: SUCCESS (18.305s)
[438.432852] [096/133] (586s left) kms_psr (psr2-suspend)
[438.541880] Starting subtest: psr2-suspend
[438.544217] Starting dynamic subtest: eDP-1
[456.353892] Dynamic subtest eDP-1: SUCCESS (3.826s)
[456.356223] Subtest psr2-suspend: SUCCESS (3.827s)
[457.169573] [097/133] (567s left) gem_ctx_persistence (file)
[457.255492] Starting subtest: file
[457.368072] Subtest file: SUCCESS (0.115s)
[457.488189] [098/133] (567s left) kms_frontbuffer_tracking (fbc-2p-rte)
[457.579587] Starting subtest: fbc-2p-rte
[457.583827] Subtest fbc-2p-rte: SKIP (0.000s)
[457.679194] [099/133] (567s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[457.792238] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[464.703864] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.907s)
[464.860665] [100/133] (560s left) kms_cursor_crc (cursor-random-32x32)
[465.010276] Starting subtest: cursor-random-32x32
[465.057659] Subtest cursor-random-32x32: SKIP (0.044s)
[465.354034] [101/133] (559s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[465.449806] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[465.454102] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[466.625315] [102/133] (558s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[467.003143] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[467.845385] [103/133] (557s left) kms_atomic_transition (plane-toggle-modeset-transition)
[467.951893] Starting subtest: plane-toggle-modeset-transition
[467.953879] Starting dynamic subtest: pipe-A-eDP-1
[480.721252] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.762s)
[480.733024] Starting dynamic subtest: pipe-B-eDP-1
[493.124870] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.401s)
[493.127557] Subtest plane-toggle-modeset-transition: SUCCESS (25.168s)
[493.959916] [104/133] (531s left) kms_cursor_crc (cursor-onscreen-32x32)
[494.117086] Starting subtest: cursor-onscreen-32x32
[494.166851] Subtest cursor-onscreen-32x32: SKIP (0.045s)
[494.470423] [105/133] (530s left) gem_mmap_gtt (fault-concurrent-x)
[494.534453] Subtest fault-concurrent-X: SKIP (0.000s)
[494.601194] [106/133] (530s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[494.722627] Starting subtest: basic-flip-after-cursor-atomic
[495.639347] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.914s)
[496.499867] [107/133] (528s left) kms_pm_rpm (fences)
[498.032639] Starting subtest: fences
[498.037329] Subtest fences: SKIP (0.000s)
[498.818534] [108/133] (526s left) kms_flip (basic-flip-vs-wf_vblank)
[498.923863] Starting subtest: basic-flip-vs-wf_vblank
[498.926040] Starting dynamic subtest: A-eDP1
[500.863636] Dynamic subtest A-eDP1: SUCCESS (1.941s)
[500.876631] Starting dynamic subtest: B-eDP1
[502.796622] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[502.815662] Starting dynamic subtest: C-eDP1
[504.725230] Dynamic subtest C-eDP1: SUCCESS (1.926s)
[504.742020] Starting dynamic subtest: D-eDP1
[506.665528] Dynamic subtest D-eDP1: SUCCESS (1.937s)
[506.670735] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.747s)
[507.894806] [109/133] (517s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[508.275112] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[509.102905] [110/133] (516s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[509.220095] Starting subtest: 2x-long-cursor-vs-flip-atomic
[509.224850] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[509.379861] [111/133] (516s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[509.462809] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[509.465120] Starting dynamic subtest: pipe-A-eDP-1
[509.946807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s)
[509.961666] Starting dynamic subtest: pipe-B-eDP-1
[511.350602] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.405s)
[511.361632] Starting dynamic subtest: pipe-C-eDP-1
[512.739594] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[512.752360] Starting dynamic subtest: pipe-D-eDP-1
[514.111144] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.373s)
[514.113293] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.622s)
[515.266925] [112/133] (510s left) gem_exec_whisper (basic-sync-all)
[515.340378] Starting subtest: basic-sync-all
[521.613623] Subtest basic-sync-all: SUCCESS (6.272s)
[521.802258] [113/133] (503s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[521.913119] Starting subtest: extended-modeset-hang-newfb-with-reset
[521.915433] Starting dynamic subtest: pipe-A
[536.268236] Dynamic subtest pipe-A: SUCCESS (14.353s)
[536.288527] Starting dynamic subtest: pipe-D
[551.762911] Dynamic subtest pipe-D: SUCCESS (15.489s)
[551.765306] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.846s)
[552.571628] [114/133] (473s left) syncobj_timeline (wait-any-snapshot)
[552.630955] Starting subtest: wait-any-snapshot
[552.710046] Subtest wait-any-snapshot: SUCCESS (0.081s)
[552.791157] [115/133] (472s left) kms_color (ctm-0-50)
[552.886803] Starting subtest: ctm-0-50
[552.888705] Starting dynamic subtest: pipe-A-eDP-1
[556.394780] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s)
[556.405243] Starting dynamic subtest: pipe-B-eDP-1
[560.652682] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.261s)
[560.664169] Starting dynamic subtest: pipe-C-eDP-1
[564.678104] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.025s)
[564.689232] Starting dynamic subtest: pipe-D-eDP-1
[568.670172] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.990s)
[568.672640] Subtest ctm-0-50: SUCCESS (15.787s)
[569.497526] [116/133] (456s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[569.571587] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[569.695811] [117/133] (456s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[569.796863] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[569.799125] Starting dynamic subtest: pipe-A
[569.818014] Dynamic subtest pipe-A: SKIP (0.018s)
[569.832089] Starting dynamic subtest: pipe-B
[569.855291] Dynamic subtest pipe-B: SKIP (0.035s)
[569.868600] Starting dynamic subtest: pipe-C
[569.891213] Dynamic subtest pipe-C: SKIP (0.034s)
[569.907525] Starting dynamic subtest: pipe-D
[569.920697] Dynamic subtest pipe-D: SKIP (0.030s)
[569.925392] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.121s)
[570.006101] [118/133] (455s left) syncobj_timeline (reset-unsignaled)
[570.068216] Starting subtest: reset-unsignaled
[570.070638] Subtest reset-unsignaled: SUCCESS (0.000s)
[570.165416] [119/133] (455s left) gem_exec_whisper (basic-fds-forked-all)
[570.244563] Starting subtest: basic-fds-forked-all
[591.836666] Subtest basic-fds-forked-all: SUCCESS (21.591s)
[592.023640] [120/133] (433s left) prime_mmap (test_forked)
[592.078154] Starting subtest: test_forked
[592.080065] Starting dynamic subtest: test_forked-smem
[592.122296] Dynamic subtest test_forked-smem: SUCCESS (0.047s)
[592.124918] Subtest test_forked: SUCCESS (0.048s)
[592.223419] [121/133] (433s left) kms_psr (psr-cursor-render)
[592.306571] Starting subtest: psr-cursor-render
[592.308886] Starting dynamic subtest: eDP-1
[594.005224] Dynamic subtest eDP-1: SUCCESS (1.697s)
[594.007472] Subtest psr-cursor-render: SUCCESS (1.698s)
[594.873825] [122/133] (431s left) gem_ctx_param (set-priority-range)
[594.918465] Starting subtest: set-priority-range
[594.932466] Subtest set-priority-range: SUCCESS (0.014s)
[595.034997] [123/133] (431s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[595.132567] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[596.278244] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.146s)
[596.391320] [124/133] (429s left) syncobj_wait (wait-for-submit-delayed-submit)
[596.442657] Starting subtest: wait-for-submit-delayed-submit
[596.544434] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[596.626051] [125/133] (429s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[596.744318] Starting subtest: flip-vs-cursor-toggle
[605.770008] Subtest flip-vs-cursor-toggle: SUCCESS (9.024s)
[606.603381] [126/133] (419s left) gem_ctx_param (invalid-size-set)
[606.672023] Starting subtest: invalid-size-set
[606.674277] Subtest invalid-size-set: SUCCESS (0.001s)
[606.790600] [127/133] (419s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[606.881429] Starting subtest: plane-all-modeset-transition-internal-panels
[606.883722] Starting dynamic subtest: pipe-A-eDP-1
[608.243991] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.361s)
[608.524721] Starting dynamic subtest: pipe-B-eDP-1
[609.564550] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.051s)
[609.837130] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.957s)
[610.669906] [128/133] (415s left) gem_softpin (evict-single-offset)
[610.723451] Starting subtest: evict-single-offset
[636.922018] Subtest evict-single-offset: SUCCESS (26.194s)
[637.008531] [129/133] (389s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[637.166470] Starting subtest: flip-vs-dpms-on-nop-interruptible
[637.168732] Starting dynamic subtest: A-eDP1
[639.063533] Dynamic subtest A-eDP1: SUCCESS (1.895s)
[639.077120] Starting dynamic subtest: B-eDP1
[640.887121] Dynamic subtest B-eDP1: SUCCESS (1.822s)
[640.900496] Starting dynamic subtest: C-eDP1
[642.705691] Dynamic subtest C-eDP1: SUCCESS (1.817s)
[642.717557] Starting dynamic subtest: D-eDP1
[644.530889] Dynamic subtest D-eDP1: SUCCESS (1.824s)
[644.533363] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.366s)
[645.716387] [130/133] (380s left) kms_rmfb (close-fd)
[645.814721] Starting subtest: close-fd
[645.816665] Starting dynamic subtest: pipe-A-eDP-1
[645.921785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[645.934178] Starting dynamic subtest: pipe-B-eDP-1
[647.081963] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s)
[647.094329] Starting dynamic subtest: pipe-C-eDP-1
[648.217536] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[648.228557] Starting dynamic subtest: pipe-D-eDP-1
[649.352386] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[649.354610] Subtest close-fd: SUCCESS (3.540s)
[650.577295] [131/133] (375s left) kms_atomic_interruptible (legacy-dpms)
[650.686563] Starting subtest: legacy-dpms
[650.688962] Starting dynamic subtest: pipe-A-eDP-1
[658.105984] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.417s)
[658.108294] Subtest legacy-dpms: SUCCESS (7.418s)
[658.937506] [132/133] (367s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[659.034510] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[665.626396] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.594s)
[665.777686] [133/133] (360s left) i915_pm_rps (thresholds-idle)
[665.841411] Starting subtest: thresholds-idle
[665.845734] Subtest thresholds-idle: SKIP (0.001s)
[665.942961] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: gem_exec_alignment
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: core_hotunplug
results: parsing output: 9/ for test: kms_selftest
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: sw_sync
results: parsing output: 13/ for test: kms_joiner
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_cursor_edge_walk
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: gem_mmap_offset
results: parsing output: 21/ for test: kms_plane
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: gem_ctx_param
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: prime_vgem
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_vm_create
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: gem_busy
results: parsing output: 40/ for test: kms_draw_crc
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_dp_link_training
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_legacy_colorkey
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_create
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_getfb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_vblank
results: parsing output: 58/ for test: i915_hangman
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_create
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_panel_fitting
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_sseu
results: parsing output: 73/ for test: gem_exec_flush
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: kms_pipe_crc_basic
results: parsing output: 86/ for test: vgem_basic
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: i915_pm_rpm
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_chamelium_frames
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: kms_busy
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: gem_fenced_exec_thrash
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: prime_mmap
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_rmfb
results: parsing output: 130/ for test: kms_atomic_interruptible
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: i915_pm_rps
Done.