[61.352962] Initializing watchdogs
[61.353028]   /dev/watchdog0
[61.368750] [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]
[61.373454] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.375996] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.379412] [001/156] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[61.462423] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[61.568697] [002/156] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[61.685971] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[61.690217] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[61.789498] [003/156] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[61.896874] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[61.899335] Starting dynamic subtest: pipe-A
[62.259195] Dynamic subtest pipe-A: SUCCESS (0.366s)
[62.268257] Starting dynamic subtest: pipe-B
[63.706699] Dynamic subtest pipe-B: SUCCESS (1.452s)
[63.715907] Starting dynamic subtest: pipe-C
[65.126236] Dynamic subtest pipe-C: SUCCESS (1.423s)
[65.133953] Starting dynamic subtest: pipe-D
[66.563430] Dynamic subtest pipe-D: SUCCESS (1.440s)
[66.565768] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.683s)
[67.760169] [004/156] (954s left) gem_exec_basic (basic)
[67.810375] Starting subtest: basic
[67.812733] Starting dynamic subtest: rcs0-smem
[67.815713] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[67.824907] Starting dynamic subtest: bcs0-smem
[67.827083] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[67.834084] Starting dynamic subtest: vcs0-smem
[67.835907] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[67.842966] Starting dynamic subtest: vcs1-smem
[67.844828] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[67.851892] Starting dynamic subtest: vecs0-smem
[67.853795] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[67.860763] Starting dynamic subtest: ccs0-smem
[67.862633] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[67.864526] Subtest basic: SUCCESS (0.015s)
[69.390184] [005/156] (952s left) kms_flip (2x-blocking-wf_vblank)
[69.482314] Starting subtest: 2x-blocking-wf_vblank
[69.493797] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[69.572088] [006/156] (952s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[69.658056] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[69.660302] Starting dynamic subtest: pipe-A-eDP-1
[70.603602] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.941s)
[70.612748] Starting dynamic subtest: pipe-B-eDP-1
[72.288942] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.683s)
[72.298579] Starting dynamic subtest: pipe-C-eDP-1
[73.961615] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.674s)
[73.971593] Starting dynamic subtest: pipe-D-eDP-1
[75.597394] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.636s)
[75.599738] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.938s)
[76.851854] [007/156] (945s left) core_debugfs (read-all-entries)
[76.908170] Starting subtest: read-all-entries
[77.002638] Subtest read-all-entries: SUCCESS (0.095s)
[77.064805] [008/156] (945s left) gem_exec_params (mmapped)
[77.127053] Starting subtest: mmapped
[77.132077] Subtest mmapped: SUCCESS (0.003s)
[77.255720] [009/156] (945s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[77.396626] Starting subtest: dp-mst-type-0-suspend-resume
[77.407677] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[77.509317] [010/156] (944s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[77.896729] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[78.766068] [011/156] (943s left) syncobj_timeline (reset-unsignaled)
[78.831070] Starting subtest: reset-unsignaled
[78.833487] Subtest reset-unsignaled: SUCCESS (0.000s)
[78.920888] [012/156] (943s left) gem_flink_basic (flink-lifetime)
[78.970956] Starting subtest: flink-lifetime
[78.973456] Subtest flink-lifetime: SUCCESS (0.002s)
[79.062736] [013/156] (943s left) kms_universal_plane (disable-primary-vs-flip)
[79.166294] Starting subtest: disable-primary-vs-flip
[79.168683] Starting dynamic subtest: pipe-A-eDP-1
[80.791236] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.627s)
[80.801096] Starting dynamic subtest: pipe-B-eDP-1
[83.058229] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.266s)
[83.067657] Starting dynamic subtest: pipe-C-eDP-1
[85.303154] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.244s)
[85.311088] Starting dynamic subtest: pipe-D-eDP-1
[87.574151] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.272s)
[87.576518] Subtest disable-primary-vs-flip: SUCCESS (8.412s)
[88.458069] [014/156] (933s left) kms_selftest (drm_dp_mst_helper)
[88.496103] Starting subtest: drm_dp_mst_helper
[88.507227] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[88.608103] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.100s)
[88.617572] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[88.704481] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.097s)
[88.714554] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[88.806206] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.100s)
[88.808142] Subtest drm_dp_mst_helper: SUCCESS (0.308s)
[88.980327] [015/156] (933s left) gem_eio (in-flight-internal-immediate)
[89.153395] Starting subtest: in-flight-internal-immediate
[90.363192] Subtest in-flight-internal-immediate: SUCCESS (1.210s)
[90.502304] [016/156] (932s left) gem_exec_schedule (preempt-hang)
[90.678670] Starting subtest: preempt-hang
[90.681408] Starting dynamic subtest: rcs0
[90.896985] Dynamic subtest rcs0: SUCCESS (0.220s)
[90.907951] Starting dynamic subtest: bcs0
[91.115774] Dynamic subtest bcs0: SUCCESS (0.218s)
[91.125879] Starting dynamic subtest: vcs0
[91.322226] Dynamic subtest vcs0: SUCCESS (0.205s)
[91.332489] Starting dynamic subtest: vcs1
[91.527056] Dynamic subtest vcs1: SUCCESS (0.202s)
[91.535373] Starting dynamic subtest: vecs0
[91.730708] Dynamic subtest vecs0: SUCCESS (0.204s)
[91.740622] Starting dynamic subtest: ccs0
[91.948664] Dynamic subtest ccs0: SUCCESS (0.219s)
[91.950840] Subtest preempt-hang: SUCCESS (1.272s)
[92.383310] [017/156] (930s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[92.440937] Starting subtest: invalid-single-wait-unsubmitted
[92.443299] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[92.562248] [018/156] (930s left) prime_vgem (basic-fence-read)
[92.666429] Starting subtest: basic-fence-read
[92.674498] Subtest basic-fence-read: SKIP (0.006s)
[92.785883] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[92.788974] [019/156] (929s left) kms_psr (fbc-psr-primary-page-flip)
[92.883879] Starting subtest: fbc-psr-primary-page-flip
[92.886211] Starting dynamic subtest: eDP-1
[92.890579] Dynamic subtest eDP-1: SKIP (0.000s)
[92.895041] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[92.956293] [020/156] (929s left) gem_exec_schedule (u-fairslice-all)
[93.021759] Starting subtest: u-fairslice-all
[95.075746] Subtest u-fairslice-all: SUCCESS (2.054s)
[95.372708] [021/156] (927s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[95.480789] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[95.484722] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[95.554170] [022/156] (927s left) template (b)
[95.609869] Starting subtest: B
[95.612207] Subtest B: SUCCESS (0.000s)
[95.714116] [023/156] (927s left) gem_mmap_wc (copy)
[95.764603] Subtest copy: SKIP (0.000s)
[95.822589] [024/156] (927s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[95.921899] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[95.947661] Starting dynamic subtest: pipe-A-plane-0
[96.236647] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[96.245303] Starting dynamic subtest: pipe-A-plane-3
[96.469539] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[97.648131] Starting dynamic subtest: pipe-B-plane-0
[97.949854] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[97.959334] Starting dynamic subtest: pipe-B-plane-3
[98.194447] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[98.506856] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.585s)
[99.317963] [025/156] (923s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[99.426271] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[99.430464] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[99.533670] [026/156] (923s left) vgem_slow (nohang)
[99.574113] Starting subtest: nohang
[110.054049] Subtest nohang: SUCCESS (10.480s)
[110.121257] [027/156] (912s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[110.226963] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[110.231339] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[110.328170] [028/156] (912s left) kms_flip (2x-flip-vs-panning-vs-hang)
[110.427147] Starting subtest: 2x-flip-vs-panning-vs-hang
[110.431398] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[110.520221] [029/156] (912s left) kms_fbcon_fbt (fbc)
[110.567986] Starting subtest: fbc
[117.050968] Subtest fbc: SUCCESS (6.483s)
[118.141716] [030/156] (904s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[118.252512] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[118.256564] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[118.336397] [031/156] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[118.451571] Starting subtest: basic-flip-before-cursor-varying-size
[119.377863] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.925s)
[120.191068] [032/156] (902s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[120.294756] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[120.299282] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[120.375066] [033/156] (902s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[120.433589] Starting subtest: yf-tiled-to-vebox-x-tiled
[120.437887] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[120.615017] [034/156] (902s left) gem_ctx_param (non-root-set)
[120.678931] Starting subtest: non-root-set
[120.699304] Subtest non-root-set: SUCCESS (0.024s)
[120.788637] [035/156] (902s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[120.879220] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[120.881470] Starting dynamic subtest: pipe-A-eDP-1
[120.904619] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[120.915341] Starting dynamic subtest: pipe-B-eDP-1
[120.937184] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[120.945727] Starting dynamic subtest: pipe-C-eDP-1
[120.967498] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[120.978468] Starting dynamic subtest: pipe-D-eDP-1
[121.000721] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[121.004855] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[123.143940] [036/156] (900s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[123.258948] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[123.263175] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[123.374997] [037/156] (900s left) perf_pmu (event-wait)
[123.415510] Starting subtest: event-wait
[123.417856] Starting dynamic subtest: rcs0
[123.422161] Dynamic subtest rcs0: SKIP (0.000s)
[123.426465] Subtest event-wait: SKIP (0.000s)
[123.521301] [038/156] (899s left) gen9_exec_parse (unaligned-jump)
[123.581304] Subtest unaligned-jump: SKIP (0.000s)
[123.647957] [039/156] (899s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[123.710927] Subtest writes-after-reads-snoop: SKIP (0.000s)
[123.778080] [040/156] (899s left) kms_lease (simple-lease)
[123.873976] Starting subtest: simple-lease
[123.876265] Starting dynamic subtest: pipe-A-eDP-1
[124.379593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.505s)
[124.389607] Starting dynamic subtest: pipe-B-eDP-1
[125.890562] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.509s)
[125.900314] Starting dynamic subtest: pipe-C-eDP-1
[127.379926] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s)
[127.389574] Starting dynamic subtest: pipe-D-eDP-1
[128.792752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.412s)
[128.794725] Subtest simple-lease: SUCCESS (4.918s)
[129.609763] [041/156] (893s left) gem_exec_balancer (invalid-bonds)
[129.687379] Starting subtest: invalid-bonds
[129.692085] Subtest invalid-bonds: SKIP (0.000s)
[130.007361] [042/156] (893s left) kms_cursor_legacy (forked-move)
[130.137839] Starting subtest: forked-move
[130.140238] Starting dynamic subtest: pipe-A
[135.603606] Dynamic subtest pipe-A: SUCCESS (5.462s)
[135.618634] Starting dynamic subtest: pipe-B
[141.088849] Dynamic subtest pipe-B: SUCCESS (5.484s)
[141.101295] Starting dynamic subtest: pipe-C
[146.565364] Dynamic subtest pipe-C: SUCCESS (5.475s)
[146.574317] Starting dynamic subtest: pipe-D
[152.040775] Dynamic subtest pipe-D: SUCCESS (5.473s)
[152.051542] Starting dynamic subtest: all-pipes
[157.572655] Dynamic subtest all-pipes: SUCCESS (5.527s)
[157.575050] Subtest forked-move: SUCCESS (27.430s)
[157.721345] [043/156] (865s left) kms_chamelium_edid (dp-mode-timings)
[158.125307] Subtest dp-mode-timings: SKIP (0.000s)
[158.926350] [044/156] (864s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[159.039028] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[159.043525] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[159.133233] [045/156] (864s left) kms_psr (pr-cursor-plane-move)
[159.233982] Starting subtest: pr-cursor-plane-move
[159.238252] Subtest pr-cursor-plane-move: SKIP (0.000s)
[159.305978] [046/156] (864s left) gem_lmem_swapping (basic)
[159.353723] Subtest basic: SKIP (0.000s)
[159.393803] [047/156] (864s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[159.485131] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[159.489343] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[159.564483] [048/156] (864s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[159.655947] Starting subtest: plane-ctm3x4-lut1d
[159.824245] Starting dynamic subtest: pipe-A-plane-0
[160.023913] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[160.033461] Starting dynamic subtest: pipe-A-plane-1
[160.201647] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[160.210913] Starting dynamic subtest: pipe-A-plane-2
[160.390775] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[161.584674] Starting dynamic subtest: pipe-B-plane-0
[161.765675] Dynamic subtest pipe-B-plane-0: SUCCESS (0.188s)
[161.775281] Starting dynamic subtest: pipe-B-plane-1
[161.921390] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[161.930862] Starting dynamic subtest: pipe-B-plane-2
[162.110994] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[163.307507] Starting dynamic subtest: pipe-C-plane-0
[163.455982] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s)
[163.467302] Starting dynamic subtest: pipe-C-plane-1
[163.623584] Dynamic subtest pipe-C-plane-1: SUCCESS (0.164s)
[163.633131] Starting dynamic subtest: pipe-C-plane-2
[163.777616] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[165.030082] Starting dynamic subtest: pipe-D-plane-0
[165.178281] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[165.187622] Starting dynamic subtest: pipe-D-plane-1
[165.344940] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[165.356360] Starting dynamic subtest: pipe-D-plane-2
[165.511180] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[165.799725] Subtest plane-ctm3x4-lut1d: SUCCESS (6.144s)
[166.674765] [049/156] (857s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[166.773061] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[166.775259] Starting dynamic subtest: pipe-A-eDP-1
[166.834227] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[166.845396] Starting dynamic subtest: pipe-B-eDP-1
[166.904201] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[166.914666] Starting dynamic subtest: pipe-C-eDP-1
[166.971762] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[166.981590] Starting dynamic subtest: pipe-D-eDP-1
[167.039172] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[167.043621] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[169.055144] [050/156] (854s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[169.115954] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[169.177316] [051/156] (854s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[169.276674] Starting subtest: fbcpsr-slowdraw
[194.496985] Subtest fbcpsr-slowdraw: SUCCESS (25.224s)
[194.644507] [052/156] (829s left) i915_hangman (error-state-basic)
[194.719209] Starting subtest: error-state-basic
[194.879326] Subtest error-state-basic: SUCCESS (0.161s)
[194.956182] [053/156] (829s left) kms_frontbuffer_tracking (fbchdr-1p-rte)
[195.067074] Starting subtest: fbchdr-1p-rte
[195.071201] Subtest fbchdr-1p-rte: SKIP (0.000s)
[195.193064] [054/156] (828s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[195.293352] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[195.295305] Starting dynamic subtest: pipe-A-eDP-1
[195.391853] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[195.402093] Starting dynamic subtest: pipe-B-eDP-1
[196.538952] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s)
[196.543431] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.249s)
[197.817415] [055/156] (826s left) kms_cursor_crc (cursor-size-hints)
[197.949496] Starting subtest: cursor-size-hints
[197.951718] Starting dynamic subtest: pipe-A-eDP-1
[198.573207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[198.583908] Starting dynamic subtest: pipe-D-eDP-1
[199.878825] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[199.881130] Subtest cursor-size-hints: SUCCESS (1.930s)
[200.780414] [056/156] (823s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[200.884717] Starting subtest: psr-rgb101010-draw-mmap-gtt
[200.888750] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[200.985286] [057/156] (823s left) gem_set_tiling_vs_pwrite
[201.119679] [058/156] (823s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[201.201944] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[201.204242] Starting dynamic subtest: pipe-A-eDP-1
[201.229196] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[201.241777] Starting dynamic subtest: pipe-B-eDP-1
[201.265668] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[201.275053] Starting dynamic subtest: pipe-C-eDP-1
[201.298791] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[201.307683] Starting dynamic subtest: pipe-D-eDP-1
[201.331621] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[201.335995] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[203.540187] [059/156] (820s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[203.637071] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[203.641532] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[203.709045] [060/156] (820s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[203.816501] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[203.820815] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[203.916394] [061/156] (820s left) kms_prop_blob (blob-prop-validate)
[203.980522] Starting subtest: blob-prop-validate
[203.982684] Subtest blob-prop-validate: SUCCESS (0.000s)
[204.086444] [062/156] (820s left) gem_wait (write-busy)
[204.145703] Starting subtest: write-busy
[204.148086] Starting dynamic subtest: all-engines
[204.754197] Dynamic subtest all-engines: SUCCESS (0.608s)
[204.768709] Starting dynamic subtest: rcs0
[205.306343] Dynamic subtest rcs0: SUCCESS (0.551s)
[205.322072] Starting dynamic subtest: bcs0
[205.853547] Dynamic subtest bcs0: SUCCESS (0.547s)
[205.868626] Starting dynamic subtest: vcs0
[207.307082] Dynamic subtest vcs0: SUCCESS (1.451s)
[207.322445] Starting dynamic subtest: vcs1
[209.288094] Dynamic subtest vcs1: SUCCESS (1.979s)
[209.303980] Starting dynamic subtest: vecs0
[211.272384] Dynamic subtest vecs0: SUCCESS (1.982s)
[211.288963] Starting dynamic subtest: ccs0
[211.822469] Dynamic subtest ccs0: SUCCESS (0.550s)
[211.825054] Subtest write-busy: SUCCESS (7.677s)
[212.038461] [063/156] (812s left) i915_pm_rpm (gem-execbuf)
[213.589589] Starting subtest: gem-execbuf
[213.592108] Starting dynamic subtest: smem0
[215.679314] Dynamic subtest smem0: SUCCESS (2.090s)
[215.681715] Subtest gem-execbuf: SUCCESS (2.092s)
[215.769254] [064/156] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[215.881183] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[223.420977] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.546s)
[223.544452] [065/156] (801s left) kms_pm_rpm (fences-dpms)
[225.478171] Starting subtest: fences-dpms
[225.482829] Subtest fences-dpms: SKIP (0.000s)
[225.866134] [066/156] (798s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[225.975814] Starting subtest: fbcpsr-2p-rte
[225.979793] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[226.068731] [067/156] (798s left) sw_sync (sync_merge_invalid)
[226.102569] Starting subtest: sync_merge_invalid
[226.126621] Subtest sync_merge_invalid: SUCCESS (0.023s)
[226.197602] [068/156] (798s left) kms_atomic_transition (modeset-transition)
[226.282072] Starting subtest: modeset-transition
[226.284107] Starting dynamic subtest: 1x-outputs
[237.385303] Dynamic subtest 1x-outputs: SUCCESS (11.103s)
[237.388028] Subtest modeset-transition: SUCCESS (11.104s)
[238.278034] [069/156] (786s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[238.381880] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[238.385998] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[238.519905] [070/156] (786s left) gem_ctx_sseu (invalid-sseu)
[238.586082] Subtest invalid-sseu: SKIP (0.000s)
[238.658705] [071/156] (786s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[238.766570] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[238.770829] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[238.899071] [072/156] (786s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[239.001548] Starting subtest: yf-tiled-addfb-size-overflow
[239.006084] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[239.113748] [073/156] (785s left) gem_workarounds (basic-read-context)
[239.179837] Starting subtest: basic-read-context
[239.188272] Subtest basic-read-context: SUCCESS (0.011s)
[239.324201] [074/156] (785s left) gem_exec_fence (syncobj-invalid-flags)
[239.740938] Starting subtest: syncobj-invalid-flags
[239.743719] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[241.380898] [075/156] (783s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[241.482843] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[241.486992] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[241.578177] [076/156] (783s left) api_intel_allocator (open-vm)
[241.634038] Starting subtest: open-vm
[241.636496] Subtest open-vm: SUCCESS (0.003s)
[241.768085] [077/156] (783s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[241.861416] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[248.540381] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.682s)
[248.667559] [078/156] (776s left) kms_cursor_crc (cursor-offscreen-32x10)
[248.829828] Starting subtest: cursor-offscreen-32x10
[248.881054] Subtest cursor-offscreen-32x10: SKIP (0.045s)
[249.155977] [079/156] (776s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[249.256470] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[249.260660] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[249.358955] [080/156] (775s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[249.417650] Starting subtest: etime-multi-wait-available-unsubmitted
[249.524742] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.108s)
[249.602798] [081/156] (775s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[249.705487] Starting subtest: yf-tiled-32bpp-rotate-180
[249.709686] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[249.801627] [082/156] (775s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[249.863513] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[249.865887] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[249.972413] [083/156] (775s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[250.071468] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[250.773511] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.703s)
[250.938484] [084/156] (774s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[251.027184] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[251.029449] Starting dynamic subtest: pipe-A-eDP-1
[251.088767] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[251.399236] Starting dynamic subtest: pipe-B-eDP-1
[252.208443] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.822s)
[252.514839] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.488s)
[253.382993] [085/156] (772s left) sysfs_defaults (readonly)
[253.444161] Starting subtest: readonly
[253.446373] Starting dynamic subtest: vecs0
[253.448660] Dynamic subtest vecs0: SUCCESS (0.000s)
[253.458186] Starting dynamic subtest: ccs0
[253.460054] Dynamic subtest ccs0: SUCCESS (0.000s)
[253.469278] Starting dynamic subtest: vcs0
[253.471445] Dynamic subtest vcs0: SUCCESS (0.000s)
[253.480348] Starting dynamic subtest: bcs0
[253.482241] Dynamic subtest bcs0: SUCCESS (0.000s)
[253.490817] Starting dynamic subtest: rcs0
[253.492796] Dynamic subtest rcs0: SUCCESS (0.000s)
[253.501115] Starting dynamic subtest: vcs1
[253.502981] Dynamic subtest vcs1: SUCCESS (0.000s)
[253.504962] Subtest readonly: SUCCESS (0.007s)
[253.545892] [086/156] (771s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[253.679397] Starting subtest: basic-busy-flip-before-cursor-atomic
[253.684057] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[253.827627] [087/156] (771s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[253.934695] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[253.938667] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[254.016093] [088/156] (771s left) kms_getfb (getfb-addfb-different-handles)
[254.110298] Starting subtest: getfb-addfb-different-handles
[254.112521] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[254.253596] [089/156] (771s left) gem_exec_reloc (basic-wc-read-active)
[254.303806] Subtest basic-wc-read-active: SKIP (0.000s)
[254.378489] [090/156] (771s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[254.442959] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[254.505531] [091/156] (771s left) kms_flip (dpms-vs-vblank-race)
[254.612491] Starting subtest: dpms-vs-vblank-race
[254.614386] Starting dynamic subtest: A-eDP1
[258.561463] Dynamic subtest A-eDP1: SUCCESS (3.948s)
[258.571521] Starting dynamic subtest: B-eDP1
[262.163963] Dynamic subtest B-eDP1: SUCCESS (3.601s)
[262.174365] Starting dynamic subtest: C-eDP1
[265.754465] Dynamic subtest C-eDP1: SUCCESS (3.589s)
[265.764363] Starting dynamic subtest: D-eDP1
[269.352478] Dynamic subtest D-eDP1: SUCCESS (3.596s)
[269.354807] Subtest dpms-vs-vblank-race: SUCCESS (14.745s)
[270.232082] [092/156] (755s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[270.285468] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[270.389556] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[270.468939] [093/156] (755s left) gem_cs_tlb (engines)
[270.519413] Starting subtest: engines
[270.521751] Starting dynamic subtest: rcs0
[272.676977] Dynamic subtest rcs0: SUCCESS (2.154s)
[272.688391] Starting dynamic subtest: bcs0
[274.834566] Dynamic subtest bcs0: SUCCESS (2.155s)
[274.847264] Starting dynamic subtest: vcs0
[276.990597] Dynamic subtest vcs0: SUCCESS (2.155s)
[277.001494] Starting dynamic subtest: vcs1
[279.145616] Dynamic subtest vcs1: SUCCESS (2.153s)
[279.156678] Starting dynamic subtest: vecs0
[281.298705] Dynamic subtest vecs0: SUCCESS (2.152s)
[281.310448] Starting dynamic subtest: ccs0
[283.452277] Dynamic subtest ccs0: SUCCESS (2.153s)
[283.454602] Subtest engines: SUCCESS (12.930s)
[283.593367] [094/156] (742s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[283.716441] Starting subtest: verify-pxp-execution-after-suspend-resume
[290.886450] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.171s)
[291.048154] [095/156] (734s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[291.161054] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[291.165099] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[291.260739] [096/156] (734s left) gem_ccs (large-ctrl-surf-copy)
[291.320642] Starting subtest: large-ctrl-surf-copy
[291.325225] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[291.448764] [097/156] (734s left) i915_suspend (basic-s3-without-i915)
[291.482055] Starting subtest: basic-s3-without-i915
[294.831334] Subtest basic-s3-without-i915: SKIP (3.343s)
[296.441129] [098/156] (729s left) perf_pmu (busy-hang)
[296.492921] Starting subtest: busy-hang
[296.495257] Starting dynamic subtest: rcs0
[297.698750] Dynamic subtest rcs0: SUCCESS (1.205s)
[297.710070] Starting dynamic subtest: bcs0
[298.848243] Dynamic subtest bcs0: SUCCESS (1.145s)
[298.859332] Starting dynamic subtest: vcs0
[300.818506] Dynamic subtest vcs0: SUCCESS (1.968s)
[300.829893] Starting dynamic subtest: vcs1
[302.794390] Dynamic subtest vcs1: SUCCESS (1.977s)
[302.806934] Starting dynamic subtest: vecs0
[304.840218] Dynamic subtest vecs0: SUCCESS (2.044s)
[304.852252] Starting dynamic subtest: ccs0
[306.018984] Dynamic subtest ccs0: SUCCESS (1.174s)
[306.021375] Subtest busy-hang: SUCCESS (9.523s)
[306.159215] [099/156] (719s left) syncobj_timeline (wait-delayed-signal)
[306.218044] Starting subtest: wait-delayed-signal
[306.322692] Subtest wait-delayed-signal: SUCCESS (0.103s)
[306.418589] [100/156] (719s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[306.519320] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc
[306.523567] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[306.628660] [101/156] (719s left) gen9_exec_parse (basic-rejected-ctx-param)
[306.702442] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[306.786508] [102/156] (719s left) gem_ctx_persistence (engines-mixed-process)
[306.841585] Starting subtest: engines-mixed-process
[306.843827] Starting dynamic subtest: rcs0
[308.303055] Dynamic subtest rcs0: SUCCESS (1.461s)
[308.314918] Starting dynamic subtest: bcs0
[310.269186] Dynamic subtest bcs0: SUCCESS (1.963s)
[310.279049] Starting dynamic subtest: vcs0
[312.327832] Dynamic subtest vcs0: SUCCESS (2.060s)
[312.338520] Starting dynamic subtest: vcs1
[314.333728] Dynamic subtest vcs1: SUCCESS (2.004s)
[314.348048] Starting dynamic subtest: vecs0
[316.310805] Dynamic subtest vecs0: SUCCESS (1.975s)
[316.321719] Starting dynamic subtest: ccs0
[318.264063] Dynamic subtest ccs0: SUCCESS (1.950s)
[318.266440] Subtest engines-mixed-process: SUCCESS (11.421s)
[318.371468] [103/156] (707s left) prime_mmap_coherency (write)
[318.443610] Starting subtest: write
[323.819334] Subtest write: SUCCESS (5.377s)
[323.958073] [104/156] (702s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-render)
[324.055778] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-render
[324.059937] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[324.156612] [105/156] (702s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[324.253818] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[324.258027] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[324.360657] [106/156] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-onoff)
[324.458714] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-onoff
[324.463127] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[324.564641] [107/156] (701s left) gem_exec_schedule (u-submit-late-slice)
[324.636172] Starting subtest: u-submit-late-slice
[324.638080] Starting dynamic subtest: rcs0
[324.668505] Dynamic subtest rcs0: SUCCESS (0.039s)
[324.683224] Starting dynamic subtest: bcs0
[324.706497] Dynamic subtest bcs0: SUCCESS (0.037s)
[324.716884] Starting dynamic subtest: vcs0
[324.740924] Dynamic subtest vcs0: SUCCESS (0.034s)
[324.753457] Starting dynamic subtest: vcs1
[324.774732] Dynamic subtest vcs1: SUCCESS (0.033s)
[324.788443] Starting dynamic subtest: vecs0
[324.809793] Dynamic subtest vecs0: SUCCESS (0.034s)
[324.819924] Starting dynamic subtest: ccs0
[324.848350] Dynamic subtest ccs0: SUCCESS (0.038s)
[324.850128] Subtest u-submit-late-slice: SUCCESS (0.220s)
[326.363225] [108/156] (700s left) gem_mmap_offset (mmap-unmap)
[326.417023] Starting subtest: mmap-unmap
[326.419391] Starting dynamic subtest: smem0
[350.856718] Dynamic subtest smem0: SUCCESS (24.437s)
[350.859698] Subtest mmap-unmap: SUCCESS (24.439s)
[350.981566] [109/156] (675s left) kms_flip (basic-flip-vs-wf_vblank)
[351.078272] Starting subtest: basic-flip-vs-wf_vblank
[351.080429] Starting dynamic subtest: A-eDP1
[352.985350] Dynamic subtest A-eDP1: SUCCESS (1.908s)
[352.997227] Starting dynamic subtest: B-eDP1
[354.922107] Dynamic subtest B-eDP1: SUCCESS (1.936s)
[354.937819] Starting dynamic subtest: C-eDP1
[356.841134] Dynamic subtest C-eDP1: SUCCESS (1.916s)
[356.852302] Starting dynamic subtest: D-eDP1
[358.776636] Dynamic subtest D-eDP1: SUCCESS (1.933s)
[358.778957] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.703s)
[360.002577] [110/156] (666s left) gem_exec_flush (basic-uc-rw-default)
[360.063724] Starting subtest: basic-uc-rw-default
[365.520382] Subtest basic-uc-rw-default: SUCCESS (5.456s)
[365.711961] [111/156] (660s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[365.826171] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[365.830219] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[365.926486] [112/156] (660s left) kms_feature_discovery (psr2)
[366.021420] Starting subtest: psr2
[366.023356] Subtest psr2: SUCCESS (0.000s)
[366.109908] [113/156] (660s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite)
[366.214727] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite
[366.218824] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[366.316097] [114/156] (660s left) gem_render_copy (y-tiled)
[366.373338] Starting subtest: y-tiled
[366.377641] Subtest y-tiled: SKIP (0.000s)
[366.561043] [115/156] (660s left) syncobj_wait (wait-any-interrupted)
[366.621984] Starting subtest: wait-any-interrupted
[366.724230] Subtest wait-any-interrupted: SUCCESS (0.101s)
[366.814578] [116/156] (660s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[366.920658] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[366.924965] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[367.025276] [117/156] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[367.133601] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[367.137943] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[367.231279] [118/156] (659s left) kms_cursor_crc (cursor-suspend)
[367.353831] Starting subtest: cursor-suspend
[367.356167] Starting dynamic subtest: pipe-A-eDP-1
[400.616135] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.238s)
[400.628786] Starting dynamic subtest: pipe-D-eDP-1
[434.575508] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.742s)
[434.577997] Subtest cursor-suspend: SUCCESS (6.985s)
[435.428776] [119/156] (591s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[435.539944] Starting subtest: bad-rotation-90-yf-tiled-ccs
[435.542469] Starting dynamic subtest: pipe-A-eDP-1
[435.568107] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[435.579942] Starting dynamic subtest: pipe-B-eDP-1
[435.605898] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[435.616306] Starting dynamic subtest: pipe-C-eDP-1
[435.641713] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[435.651891] Starting dynamic subtest: pipe-D-eDP-1
[435.678160] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[435.683873] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[437.787367] [120/156] (589s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[437.893637] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[444.466151] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.614s)
[444.592394] [121/156] (582s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[444.695824] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[444.700774] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[444.787179] [122/156] (582s left) kms_big_fb (linear-16bpp-rotate-0)
[444.896113] Starting subtest: linear-16bpp-rotate-0
[446.381561] Subtest linear-16bpp-rotate-0: SUCCESS (1.491s)
[446.502766] [123/156] (580s left) prime_busy (after)
[446.555524] Starting subtest: after
[446.561017] Starting dynamic subtest: rcs0
[446.596157] Dynamic subtest rcs0: SUCCESS (0.038s)
[446.608561] Starting dynamic subtest: bcs0
[446.647954] Dynamic subtest bcs0: SUCCESS (0.051s)
[446.659607] Starting dynamic subtest: vcs0
[446.690198] Dynamic subtest vcs0: SUCCESS (0.041s)
[446.703303] Starting dynamic subtest: vcs1
[446.732530] Dynamic subtest vcs1: SUCCESS (0.042s)
[446.743678] Starting dynamic subtest: vecs0
[446.774540] Dynamic subtest vecs0: SUCCESS (0.041s)
[446.785719] Starting dynamic subtest: ccs0
[446.816314] Dynamic subtest ccs0: SUCCESS (0.041s)
[446.925655] Subtest after: SUCCESS (0.369s)
[447.003238] [124/156] (580s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[447.097272] Starting subtest: stress-xrgb8888-yftiled
[447.102253] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[447.174756] [125/156] (580s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[447.281117] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[447.286075] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[447.362001] [126/156] (579s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt)
[447.457878] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt
[447.463097] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[447.536890] [127/156] (579s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[447.644283] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[447.649236] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[447.735749] [128/156] (579s left) kms_rotation_crc (primary-rotation-90)
[447.818638] Starting subtest: primary-rotation-90
[447.823486] Subtest primary-rotation-90: SKIP (0.001s)
[447.894006] [129/156] (579s left) kms_addfb_basic (clobberred-modifier)
[447.941788] Starting subtest: clobberred-modifier
[447.945457] Subtest clobberred-modifier: SKIP (0.000s)
[448.080767] [130/156] (579s left) kms_atomic_interruptible (universal-setplane-primary)
[448.165519] Starting subtest: universal-setplane-primary
[448.167753] Starting dynamic subtest: pipe-A-eDP-1
[455.583871] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.430s)
[455.586524] Subtest universal-setplane-primary: SUCCESS (7.432s)
[456.439618] [131/156] (571s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[456.543997] Starting subtest: extended-pageflip-modeset-hang-oldfb
[456.546509] Starting dynamic subtest: pipe-A
[464.453572] Dynamic subtest pipe-A: SUCCESS (7.915s)
[464.464164] Starting dynamic subtest: pipe-D
[473.049905] Dynamic subtest pipe-D: SUCCESS (8.589s)
[473.052394] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.510s)
[473.913910] [132/156] (553s left) gem_pxp (create-regular-buffer)
[474.057874] Starting subtest: create-regular-buffer
[474.061065] Subtest create-regular-buffer: SUCCESS (0.000s)
[474.166010] [133/156] (553s left) gem_lmem_swapping (verify-random-ccs)
[474.213097] Subtest verify-random-ccs: SKIP (0.000s)
[474.263441] [134/156] (553s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[474.361982] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[478.430122] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.074s)
[479.620012] [135/156] (548s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[479.732255] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[479.737216] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[479.839912] [136/156] (547s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[479.930011] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[479.932573] Starting dynamic subtest: pipe-A
[479.952077] Dynamic subtest pipe-A: SKIP (0.019s)
[479.963275] Starting dynamic subtest: pipe-B
[479.985980] Dynamic subtest pipe-B: SKIP (0.032s)
[479.996901] Starting dynamic subtest: pipe-C
[480.020158] Dynamic subtest pipe-C: SKIP (0.032s)
[480.031018] Starting dynamic subtest: pipe-D
[480.052188] Dynamic subtest pipe-D: SKIP (0.032s)
[480.057057] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.119s)
[480.144900] [137/156] (547s left) kms_flip (dpms-off-confusion)
[480.233062] Starting subtest: dpms-off-confusion
[480.235795] Starting dynamic subtest: A-eDP1
[488.915705] Dynamic subtest A-eDP1: SUCCESS (8.684s)
[488.927270] Starting dynamic subtest: B-eDP1
[497.662752] Dynamic subtest B-eDP1: SUCCESS (8.746s)
[497.673516] Starting dynamic subtest: C-eDP1
[506.384014] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[506.397764] Starting dynamic subtest: D-eDP1
[515.113156] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[515.116133] Subtest dpms-off-confusion: SUCCESS (34.891s)
[516.288762] [138/156] (511s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[516.392061] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[516.472736] [139/156] (511s left) vgem_basic (debugfs)
[516.513116] Starting subtest: debugfs
[516.515448] Subtest debugfs: SUCCESS (0.000s)
[516.574893] [140/156] (511s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[516.674009] Starting subtest: y-tiled-32bpp-rotate-270
[516.678532] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[516.761363] [141/156] (511s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[516.855021] Starting subtest: x-tiled-8bpp-rotate-0
[518.091070] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.237s)
[518.217063] [142/156] (509s left) kms_psr (fbc-pr-sprite-render)
[518.301994] Starting subtest: fbc-pr-sprite-render
[518.305938] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[518.377786] [143/156] (509s left) gem_mmap_gtt (big-bo)
[518.435917] Subtest big-bo: SKIP (0.000s)
[518.500291] [144/156] (509s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[518.558984] Starting subtest: invalid-multi-wait-unsubmitted
[518.561750] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[518.646677] [145/156] (509s left) gem_softpin (safe-alignment)
[518.704625] Starting subtest: safe-alignment
[518.726774] Subtest safe-alignment: SUCCESS (0.023s)
[520.618029] [146/156] (507s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[520.709741] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[520.714839] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[520.802995] [147/156] (507s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[520.908119] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[520.913104] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[520.995660] [148/156] (507s left) kms_psr (psr2-no-drrs)
[521.097271] Starting subtest: psr2-no-drrs
[521.099998] Starting dynamic subtest: eDP-1
[522.775089] Dynamic subtest eDP-1: SUCCESS (1.678s)
[522.778004] Subtest psr2-no-drrs: SUCCESS (1.679s)
[523.652951] [149/156] (504s left) kms_hdr (static-toggle-dpms)
[523.746101] Starting subtest: static-toggle-dpms
[523.753964] Subtest static-toggle-dpms: SKIP (0.000s)
[523.845531] [150/156] (504s left) gem_ctx_persistence (idempotent)
[523.899958] Starting subtest: idempotent
[523.902255] Subtest idempotent: SUCCESS (0.000s)
[523.999717] [151/156] (504s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[524.094059] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[524.099187] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[524.190789] [152/156] (504s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[524.296212] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[527.992694] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.703s)
[529.164442] [153/156] (499s left) drm_read (short-buffer-wakeup)
[529.311613] Starting subtest: short-buffer-wakeup
[561.537239] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[561.686794] [154/156] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[561.792962] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[561.797571] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[561.898899] [155/156] (466s left) kms_joiner (basic-ultra-joiner)
[561.999936] Starting subtest: basic-ultra-joiner
[562.004494] Subtest basic-ultra-joiner: SKIP (0.000s)
[562.073180] [156/156] (466s left) kms_vblank (wait-busy-hang)
[562.167276] Starting subtest: wait-busy-hang
[562.169921] Starting dynamic subtest: pipe-A-eDP-1
[588.365813] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.198s)
[588.383693] Starting dynamic subtest: pipe-D-eDP-1
[603.317113] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.953s)
[603.320097] Subtest wait-busy-hang: SUCCESS (41.156s)
[604.207610] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_su
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: gem_exec_basic
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: core_debugfs
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: kms_content_protection
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_flink_basic
results: parsing output: 12/ for test: kms_universal_plane
results: parsing output: 13/ for test: kms_selftest
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: prime_vgem
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: template
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: vgem_slow
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_fbcon_fbt
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: gem_ctx_param
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: gen9_exec_parse
results: parsing output: 38/ for test: gem_partial_pwrite_pread
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_chamelium_edid
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_prop_blob
results: parsing output: 61/ for test: gem_wait
results: parsing output: 62/ for test: i915_pm_rpm
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: sw_sync
results: parsing output: 67/ for test: kms_atomic_transition
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_ctx_sseu
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: gem_exec_fence
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: api_intel_allocator
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_atomic_transition
results: parsing output: 84/ for test: sysfs_defaults
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_getfb
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_pipe_b_c_ivb
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_cs_tlb
results: parsing output: 93/ for test: gem_pxp
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_ccs
results: parsing output: 96/ for test: i915_suspend
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: prime_mmap_coherency
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_mmap_offset
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_feature_discovery
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: prime_busy
results: parsing output: 123/ for test: kms_pipe_stress
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_rotation_crc
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_atomic_interruptible
results: parsing output: 130/ for test: kms_busy
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: gem_lmem_swapping
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_plane_scaling
results: parsing output: 136/ for test: kms_flip
results: parsing output: 137/ for test: kms_addfb_basic
results: parsing output: 138/ for test: vgem_basic
results: parsing output: 139/ for test: kms_big_fb
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: gem_mmap_gtt
results: parsing output: 143/ for test: syncobj_wait
results: parsing output: 144/ for test: gem_softpin
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_psr
results: parsing output: 148/ for test: kms_hdr
results: parsing output: 149/ for test: gem_ctx_persistence
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: drm_read
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_joiner
results: parsing output: 155/ for test: kms_vblank
Done.