[57.871102] Initializing watchdogs
[57.871149]   /dev/watchdog0
[57.904358] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.916740] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.921597] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.924853] [001/132] (960s left) core_setmaster (master-drop-set-root)
[58.010129] Starting subtest: master-drop-set-root
[58.028121] Subtest master-drop-set-root: SUCCESS (0.015s)
[58.069441] [002/132] (960s left) gem_sync (basic-each)
[58.154508] Starting subtest: basic-each
[60.787928] Subtest basic-each: SUCCESS (2.643s)
[60.976335] [003/132] (957s left) kms_big_fb (linear-64bpp-rotate-0)
[61.082563] Starting subtest: linear-64bpp-rotate-0
[62.672740] Subtest linear-64bpp-rotate-0: SUCCESS (1.591s)
[62.839237] [004/132] (955s left) gem_ctx_param (non-root-set)
[62.888624] Starting subtest: non-root-set
[62.911670] Subtest non-root-set: SUCCESS (0.023s)
[62.998511] [005/132] (955s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[63.085181] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[70.391040] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.304s)
[70.527187] [006/132] (948s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[70.614877] Starting subtest: plane-lut1d-post-ctm3x4
[70.783271] Starting dynamic subtest: pipe-A-plane-0
[71.138651] Dynamic subtest pipe-A-plane-0: FAIL (0.186s)
[71.147121] Starting dynamic subtest: pipe-A-plane-1
[71.357851] Dynamic subtest pipe-A-plane-1: FAIL (0.155s)
[71.365130] Starting dynamic subtest: pipe-A-plane-2
[71.573189] Dynamic subtest pipe-A-plane-2: FAIL (0.178s)
[72.533756] Starting dynamic subtest: pipe-B-plane-0
[72.959754] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[72.966804] Starting dynamic subtest: pipe-B-plane-1
[73.278469] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[73.288103] Starting dynamic subtest: pipe-B-plane-2
[73.585073] Dynamic subtest pipe-B-plane-2: FAIL (0.178s)
[74.261676] Starting dynamic subtest: pipe-C-plane-0
[74.766586] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[74.774518] Starting dynamic subtest: pipe-C-plane-1
[75.160741] Dynamic subtest pipe-C-plane-1: FAIL (0.155s)
[75.167839] Starting dynamic subtest: pipe-C-plane-2
[75.521097] Dynamic subtest pipe-C-plane-2: FAIL (0.622s)
[76.359727] Starting dynamic subtest: pipe-D-plane-0
[76.978355] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[76.986599] Starting dynamic subtest: pipe-D-plane-1
[77.437621] Dynamic subtest pipe-D-plane-1: FAIL (0.619s)
[77.447046] Starting dynamic subtest: pipe-D-plane-2
[77.886481] Dynamic subtest pipe-D-plane-2: FAIL (0.564s)
[78.003996] Subtest plane-lut1d-post-ctm3x4: FAIL (7.389s)
[78.830083] [007/132] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[78.935976] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[85.990681] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.056s)
[86.115042] [008/132] (932s left) kms_vrr (lobf)
[86.208392] Starting subtest: lobf
[86.212674] Subtest lobf: SKIP (0.000s)
[86.292867] [009/132] (932s left) kms_addfb_basic (addfb25-bad-modifier)
[86.380651] Starting subtest: addfb25-bad-modifier
[86.382873] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[86.468194] [010/132] (932s left) syncobj_basic (bad-destroy)
[86.523876] Starting subtest: bad-destroy
[86.526058] Subtest bad-destroy: SUCCESS (0.000s)
[86.610980] [011/132] (932s left) kms_psr (psr2-primary-render)
[86.701737] Starting subtest: psr2-primary-render
[86.703960] Starting dynamic subtest: eDP-1
[88.429384] Dynamic subtest eDP-1: SUCCESS (1.726s)
[88.431561] Subtest psr2-primary-render: SUCCESS (1.727s)
[89.280623] [012/132] (929s left) gem_ctx_param (invalid-param-get)
[89.330657] Starting subtest: invalid-param-get
[89.332981] Subtest invalid-param-get: SUCCESS (0.001s)
[89.443558] [013/132] (929s left) gem_gtt_cpu_tlb
[89.569474] [014/132] (929s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[89.671299] Starting subtest: compare-crc-sanitycheck-nv12
[89.673309] Starting dynamic subtest: pipe-A-eDP-1
[90.376029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[90.383905] Starting dynamic subtest: pipe-B-eDP-1
[91.682396] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.305s)
[91.689909] Starting dynamic subtest: pipe-C-eDP-1
[92.954632] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.270s)
[92.967258] Starting dynamic subtest: pipe-D-eDP-1
[94.188421] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[94.190330] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.517s)
[95.014475] [015/132] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[95.113128] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[95.117612] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[95.212834] [016/132] (923s left) kms_cursor_crc (cursor-onscreen-128x128)
[95.433870] Starting subtest: cursor-onscreen-128x128
[95.436190] Starting dynamic subtest: pipe-A-eDP-1
[97.561279] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.125s)
[97.591419] Starting dynamic subtest: pipe-D-eDP-1
[100.371944] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.787s)
[100.374312] Subtest cursor-onscreen-128x128: SUCCESS (4.940s)
[101.246207] [017/132] (917s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[101.304743] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[101.367502] [018/132] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[101.457613] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[101.462013] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[101.555458] [019/132] (917s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[101.658900] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[102.304587] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[102.497427] [020/132] (916s left) i915_pm_rc6_residency (rc6-accuracy)
[102.560057] Starting subtest: rc6-accuracy
[102.562375] Starting dynamic subtest: gt0
[105.736296] Dynamic subtest gt0: SUCCESS (3.170s)
[105.746179] Starting dynamic subtest: gt1
[108.908464] Dynamic subtest gt1: SUCCESS (3.170s)
[108.911114] Subtest rc6-accuracy: SUCCESS (6.345s)
[109.000834] [021/132] (910s left) gem_ctx_shared (q-independent)
[109.061642] Starting subtest: Q-independent
[109.063963] Starting dynamic subtest: rcs0
[109.184302] Dynamic subtest rcs0: SUCCESS (0.121s)
[109.193973] Starting dynamic subtest: vcs0
[109.258249] Dynamic subtest vcs0: SUCCESS (0.074s)
[109.267702] Starting dynamic subtest: vcs1
[109.322758] Dynamic subtest vcs1: SUCCESS (0.064s)
[109.332634] Starting dynamic subtest: vecs0
[109.389628] Dynamic subtest vecs0: SUCCESS (0.066s)
[109.400173] Starting dynamic subtest: ccs0
[109.469154] Dynamic subtest ccs0: SUCCESS (0.079s)
[109.471868] Subtest Q-independent: SUCCESS (0.407s)
[111.053519] [022/132] (908s left) api_intel_bb (lot-of-buffers)
[111.122699] Starting subtest: lot-of-buffers
[112.169852] Subtest lot-of-buffers: SUCCESS (1.047s)
[112.933525] [023/132] (906s left) gem_partial_pwrite_pread (write)
[112.996061] Subtest write: SKIP (0.000s)
[113.052453] [024/132] (906s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[113.157304] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[117.449986] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.295s)
[118.662176] [025/132] (900s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[118.765663] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[118.770052] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[118.845240] [026/132] (900s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[118.936748] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[118.939049] Starting dynamic subtest: pipe-A-default-mode
[121.686897] Dynamic subtest pipe-A-default-mode: SUCCESS (2.748s)
[121.689200] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.750s)
[122.523834] [027/132] (896s left) syncobj_timeline (invalid-query-one-illegal-handle)
[122.583044] Starting subtest: invalid-query-one-illegal-handle
[122.585084] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[122.690919] [028/132] (896s left) kms_cursor_legacy (torture-bo)
[122.800286] Starting subtest: torture-bo
[122.802497] Starting dynamic subtest: pipe-A
[129.088046] Dynamic subtest pipe-A: SUCCESS (6.284s)
[129.098663] Starting dynamic subtest: pipe-B
[135.338506] Dynamic subtest pipe-B: SUCCESS (6.250s)
[135.346255] Starting dynamic subtest: pipe-C
[141.190863] Dynamic subtest pipe-C: SUCCESS (5.850s)
[141.200787] Starting dynamic subtest: pipe-D
[148.881776] Dynamic subtest pipe-D: SUCCESS (7.689s)
[148.893033] Starting dynamic subtest: all-pipes
[155.386217] Dynamic subtest all-pipes: SUCCESS (6.504s)
[155.388580] Subtest torture-bo: SUCCESS (32.584s)
[155.557528] [029/132] (863s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[155.674276] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[155.678686] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[155.749790] [030/132] (863s left) api_intel_bb (blit-noreloc-purge-cache)
[155.804027] Starting subtest: blit-noreloc-purge-cache
[155.818157] Subtest blit-noreloc-purge-cache: SUCCESS (0.015s)
[155.926308] [031/132] (863s left) gem_eio (banned)
[156.161660] Starting subtest: banned
[156.767122] Subtest banned: SUCCESS (0.606s)
[156.915854] [032/132] (862s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[157.012180] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[157.015771] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[157.078588] [033/132] (862s left) gem_ctx_isolation (nonpriv-switch)
[157.151526] Starting subtest: nonpriv-switch
[157.153201] Starting dynamic subtest: rcs0
[157.435415] Dynamic subtest rcs0: SUCCESS (0.286s)
[157.445421] Starting dynamic subtest: bcs0
[157.723447] Dynamic subtest bcs0: SUCCESS (0.287s)
[157.733623] Starting dynamic subtest: vcs0
[158.051873] Dynamic subtest vcs0: SUCCESS (0.328s)
[158.059609] Starting dynamic subtest: vcs1
[159.160872] Dynamic subtest vcs1: SUCCESS (1.107s)
[159.175053] Starting dynamic subtest: vecs0
[161.192746] Dynamic subtest vecs0: SUCCESS (2.031s)
[161.202855] Starting dynamic subtest: ccs0
[163.251955] Dynamic subtest ccs0: SUCCESS (2.058s)
[163.254429] Subtest nonpriv-switch: SUCCESS (6.103s)
[163.526731] [034/132] (856s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[163.621915] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[163.626259] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[163.694141] [035/132] (856s left) gem_wait (busy)
[163.753772] Starting subtest: busy
[163.756098] Starting dynamic subtest: all-engines
[164.884049] Dynamic subtest all-engines: SUCCESS (1.128s)
[164.894346] Starting dynamic subtest: rcs0
[165.426599] Dynamic subtest rcs0: SUCCESS (0.541s)
[165.435927] Starting dynamic subtest: bcs0
[165.965652] Dynamic subtest bcs0: SUCCESS (0.538s)
[165.973646] Starting dynamic subtest: vcs0
[167.892049] Dynamic subtest vcs0: SUCCESS (1.924s)
[167.904196] Starting dynamic subtest: vcs1
[169.875943] Dynamic subtest vcs1: SUCCESS (1.982s)
[169.886531] Starting dynamic subtest: vecs0
[171.924041] Dynamic subtest vecs0: SUCCESS (2.046s)
[171.934683] Starting dynamic subtest: ccs0
[172.465574] Dynamic subtest ccs0: SUCCESS (0.541s)
[172.468092] Subtest busy: SUCCESS (8.711s)
[172.663086] [036/132] (847s left) syncobj_basic (bad-destroy-pad)
[172.725417] Starting subtest: bad-destroy-pad
[172.727778] Subtest bad-destroy-pad: SUCCESS (0.000s)
[172.826566] [037/132] (847s left) kms_pm_rpm (system-suspend-modeset)
[175.061085] Starting subtest: system-suspend-modeset
[194.537693] Subtest system-suspend-modeset: SUCCESS (4.415s)
[194.915985] [038/132] (824s left) gem_ppgtt (shrink-vs-evict-pinned)
[194.981797] Starting subtest: shrink-vs-evict-pinned
[202.959933] Subtest shrink-vs-evict-pinned: SUCCESS (7.904s)
[202.997572] [039/132] (816s left) kms_cursor_edge_walk (64x64-top-edge)
[203.112527] Starting subtest: 64x64-top-edge
[203.114677] Starting dynamic subtest: pipe-A-eDP-1
[206.582235] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s)
[206.593576] Starting dynamic subtest: pipe-D-eDP-1
[209.726995] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s)
[209.729133] Subtest 64x64-top-edge: SUCCESS (6.607s)
[210.526133] [040/132] (809s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[210.915441] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[211.728468] [041/132] (808s left) gem_render_copy (y-tiled)
[211.791135] Starting subtest: y-tiled
[211.795741] Subtest y-tiled: SKIP (0.000s)
[211.974888] [042/132] (808s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[212.082820] Starting subtest: x-tiled-16bpp-rotate-270
[212.102381] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[212.227184] [043/132] (807s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[212.315691] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[212.318052] Starting dynamic subtest: pipe-A
[213.442529] Dynamic subtest pipe-A: SUCCESS (1.128s)
[213.453013] Starting dynamic subtest: pipe-B
[215.770851] Dynamic subtest pipe-B: SUCCESS (2.325s)
[215.787192] Starting dynamic subtest: pipe-C
[216.951123] Dynamic subtest pipe-C: SUCCESS (1.177s)
[216.963430] Starting dynamic subtest: pipe-D
[218.100836] Dynamic subtest pipe-D: SUCCESS (1.148s)
[218.103103] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.785s)
[219.290014] [044/132] (800s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[219.373476] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[219.375812] Starting dynamic subtest: pipe-A-eDP-1
[219.401669] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[219.411859] Starting dynamic subtest: pipe-B-eDP-1
[219.436151] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[219.444628] Starting dynamic subtest: pipe-C-eDP-1
[219.468674] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[219.476720] Starting dynamic subtest: pipe-D-eDP-1
[219.500843] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[219.505281] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[221.654459] [045/132] (798s left) kms_draw_crc (fill-fb)
[221.743661] Starting subtest: fill-fb
[222.228405] Subtest fill-fb: SUCCESS (0.486s)
[222.320822] [046/132] (797s left) kms_psr (fbc-psr-cursor-plane-onoff)
[222.421410] Starting subtest: fbc-psr-cursor-plane-onoff
[222.423762] Starting dynamic subtest: eDP-1
[222.428229] Dynamic subtest eDP-1: SKIP (0.000s)
[222.432673] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[222.494804] [047/132] (797s left) gem_exec_schedule (smoketest)
[222.672590] Starting subtest: smoketest
[222.675250] Starting dynamic subtest: rcs0
[228.299321] Dynamic subtest rcs0: SUCCESS (5.525s)
[228.309016] Starting dynamic subtest: bcs0
[233.804033] Dynamic subtest bcs0: SUCCESS (5.506s)
[233.815281] Starting dynamic subtest: vcs0
[239.294813] Dynamic subtest vcs0: SUCCESS (5.488s)
[239.310355] Starting dynamic subtest: vcs1
[244.785594] Dynamic subtest vcs1: SUCCESS (5.487s)
[244.799424] Starting dynamic subtest: vecs0
[250.282851] Dynamic subtest vecs0: SUCCESS (5.499s)
[250.292085] Starting dynamic subtest: ccs0
[255.796503] Dynamic subtest ccs0: SUCCESS (5.505s)
[255.798886] Subtest smoketest: SUCCESS (33.019s)
[255.881763] [048/132] (764s left) core_auth (basic-auth)
[255.949087] Starting subtest: basic-auth
[255.951280] Subtest basic-auth: SUCCESS (0.001s)
[256.045248] [049/132] (764s left) kms_sequence (get-forked)
[256.149593] Starting subtest: get-forked
[256.151893] Starting dynamic subtest: pipe-A-eDP-1
[258.059183] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.907s)
[258.068182] Starting dynamic subtest: pipe-B-eDP-1
[260.614692] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.556s)
[260.624393] Starting dynamic subtest: pipe-C-eDP-1
[263.110765] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.493s)
[263.120716] Starting dynamic subtest: pipe-D-eDP-1
[265.652192] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[265.654588] Subtest get-forked: SUCCESS (9.501s)
[266.485408] [050/132] (753s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[266.588306] Starting subtest: extended-modeset-hang-newfb-with-reset
[266.590736] Starting dynamic subtest: pipe-A
[282.360668] Dynamic subtest pipe-A: SUCCESS (15.764s)
[282.370302] Starting dynamic subtest: pipe-D
[297.851944] Dynamic subtest pipe-D: SUCCESS (15.490s)
[297.854345] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.260s)
[298.642187] [051/132] (721s left) kms_flip (plain-flip-interruptible)
[298.727774] Starting subtest: plain-flip-interruptible
[298.730024] Starting dynamic subtest: A-eDP1
[300.356313] Dynamic subtest A-eDP1: SUCCESS (1.628s)
[300.366965] Starting dynamic subtest: B-eDP1
[301.970595] Dynamic subtest B-eDP1: SUCCESS (1.613s)
[301.982337] Starting dynamic subtest: C-eDP1
[303.588614] Dynamic subtest C-eDP1: SUCCESS (1.616s)
[303.599171] Starting dynamic subtest: D-eDP1
[305.233136] Dynamic subtest D-eDP1: SUCCESS (1.644s)
[305.238232] Subtest plain-flip-interruptible: SUCCESS (6.511s)
[306.386286] [052/132] (714s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[306.475652] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[306.479763] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[306.563222] [053/132] (713s left) kms_psr (psr2-cursor-mmap-cpu)
[306.651226] Starting subtest: psr2-cursor-mmap-cpu
[306.653311] Starting dynamic subtest: eDP-1
[308.381251] Dynamic subtest eDP-1: SUCCESS (1.730s)
[308.383660] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.731s)
[309.258293] [054/132] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[309.367721] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[309.371690] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[309.456803] [055/132] (711s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[309.553683] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[309.557697] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[309.645852] [056/132] (710s left) perf (i915-ref-count)
[309.701722] Starting subtest: i915-ref-count
[309.765335] Subtest i915-ref-count: SUCCESS (0.061s)
[309.817842] [057/132] (710s left) i915_drm_fdinfo (busy)
[309.855973] Starting subtest: busy
[309.857980] Starting dynamic subtest: rcs0
[309.878474] Dynamic subtest rcs0: SKIP (0.022s)
[309.889723] Starting dynamic subtest: bcs0
[309.893748] Dynamic subtest bcs0: SKIP (0.000s)
[309.902642] Starting dynamic subtest: vcs0
[309.907069] Dynamic subtest vcs0: SKIP (0.000s)
[309.915508] Starting dynamic subtest: vcs1
[309.919666] Dynamic subtest vcs1: SKIP (0.000s)
[309.928044] Starting dynamic subtest: vecs0
[309.932149] Dynamic subtest vecs0: SKIP (0.000s)
[309.940263] Starting dynamic subtest: ccs0
[309.944351] Dynamic subtest ccs0: SKIP (0.000s)
[309.948504] Subtest busy: SKIP (0.027s)
[309.984654] [058/132] (710s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[310.078760] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[310.080641] Starting dynamic subtest: pipe-A-eDP-1
[312.301390] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.223s)
[312.310723] Starting dynamic subtest: pipe-B-eDP-1
[314.792030] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.489s)
[314.801261] Starting dynamic subtest: pipe-C-eDP-1
[316.957066] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.164s)
[316.966360] Starting dynamic subtest: pipe-D-eDP-1
[319.156930] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.200s)
[319.158787] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.081s)
[320.371459] [059/132] (700s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[320.470754] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[320.473035] Starting dynamic subtest: pipe-A-eDP-1
[326.337923] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.871s)
[326.347579] Starting dynamic subtest: pipe-B-eDP-1
[332.977106] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.636s)
[332.979364] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.510s)
[333.843677] [060/132] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[333.942102] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[340.583993] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.643s)
[340.732220] [061/132] (680s left) fbdev (info)
[340.771413] Starting subtest: info
[340.773737] Subtest info: SUCCESS (0.000s)
[340.853425] [062/132] (679s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[340.912671] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[340.914982] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[341.009387] [063/132] (679s left) gem_eio (throttle)
[341.239265] Starting subtest: throttle
[341.586627] Subtest throttle: SUCCESS (0.347s)
[341.698311] [064/132] (679s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[341.807783] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[341.811184] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[341.898362] [065/132] (679s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[341.990223] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[341.993847] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[342.087310] [066/132] (678s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[342.180697] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[342.184056] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[342.278737] [067/132] (678s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[342.334381] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[342.387490] [068/132] (678s left) kms_rotation_crc (cursor-rotation-180)
[342.473247] Starting subtest: cursor-rotation-180
[344.051668] Subtest cursor-rotation-180: SUCCESS (1.577s)
[345.215807] [069/132] (675s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[345.321580] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[352.250875] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.930s)
[352.383056] [070/132] (668s left) prime_vgem (busy)
[352.517653] Starting subtest: busy
[352.519970] Starting dynamic subtest: rcs0
[352.558027] Dynamic subtest rcs0: SUCCESS (0.040s)
[352.567262] Starting dynamic subtest: bcs0
[352.606968] Dynamic subtest bcs0: SUCCESS (0.048s)
[352.616095] Starting dynamic subtest: vcs0
[352.654728] Dynamic subtest vcs0: SUCCESS (0.046s)
[352.663567] Starting dynamic subtest: vcs1
[352.698393] Dynamic subtest vcs1: SUCCESS (0.043s)
[352.707911] Starting dynamic subtest: vecs0
[352.745757] Dynamic subtest vecs0: SUCCESS (0.046s)
[352.754676] Starting dynamic subtest: ccs0
[352.791232] Dynamic subtest ccs0: SUCCESS (0.044s)
[352.793474] Subtest busy: SUCCESS (0.274s)
[352.902591] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[352.905873] [071/132] (668s left) perf (unprivileged-single-ctx-counters)
[353.004122] Starting subtest: unprivileged-single-ctx-counters
[353.008296] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[353.046286] [072/132] (668s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[353.601374] Starting subtest: syncobj-backward-timeline-chain-engines
[353.727382] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.125s)
[355.007132] [073/132] (666s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[357.153875] Starting subtest: dpms-mode-unset-lpsp
[361.215417] Subtest dpms-mode-unset-lpsp: SUCCESS (4.064s)
[361.596760] [074/132] (659s left) gem_ctx_persistence (legacy-engines-hang)
[361.673193] Starting subtest: legacy-engines-hang
[361.675138] Starting dynamic subtest: render
[361.782150] Dynamic subtest render: SUCCESS (0.112s)
[361.796746] Starting dynamic subtest: bsd1
[361.853098] Dynamic subtest bsd1: SUCCESS (0.068s)
[361.865359] Starting dynamic subtest: bsd2
[361.971229] Dynamic subtest bsd2: SUCCESS (0.115s)
[361.986565] Starting dynamic subtest: blt
[362.042158] Dynamic subtest blt: SUCCESS (0.068s)
[362.052308] Starting dynamic subtest: vebox
[362.140156] Dynamic subtest vebox: SUCCESS (0.096s)
[362.142608] Subtest legacy-engines-hang: SUCCESS (0.472s)
[362.276890] [075/132] (659s left) kms_chamelium_edid (hdmi-mode-timings)
[362.663421] Subtest hdmi-mode-timings: SKIP (0.000s)
[363.495592] [076/132] (657s left) kms_fb_coherency (memset-crc)
[363.586621] Starting subtest: memset-crc
[363.588917] Starting dynamic subtest: mmap-offset-wc
[363.996915] Dynamic subtest mmap-offset-wc: SUCCESS (0.409s)
[364.298396] Starting dynamic subtest: mmap-offset-uc
[370.458455] Dynamic subtest mmap-offset-uc: SUCCESS (6.166s)
[370.757820] Subtest memset-crc: SUCCESS (7.169s)
[371.582815] [077/132] (649s left) kms_rmfb (close-fd)
[371.673668] Starting subtest: close-fd
[371.675606] Starting dynamic subtest: pipe-A-eDP-1
[371.783085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[371.793111] Starting dynamic subtest: pipe-B-eDP-1
[372.945588] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s)
[372.955260] Starting dynamic subtest: pipe-C-eDP-1
[374.087442] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.141s)
[374.096970] Starting dynamic subtest: pipe-D-eDP-1
[375.212119] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[375.214479] Subtest close-fd: SUCCESS (3.540s)
[376.431035] [078/132] (644s left) gem_exec_basic (basic)
[376.496336] Starting subtest: basic
[376.498766] Starting dynamic subtest: rcs0-smem
[376.501087] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[376.511985] Starting dynamic subtest: bcs0-smem
[376.514209] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[376.523411] Starting dynamic subtest: vcs0-smem
[376.525612] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[376.534454] Starting dynamic subtest: vcs1-smem
[376.536728] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[376.545588] Starting dynamic subtest: vecs0-smem
[376.547767] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[376.557074] Starting dynamic subtest: ccs0-smem
[376.559286] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[376.561476] Subtest basic: SUCCESS (0.013s)
[377.994806] [079/132] (643s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[378.128009] Starting subtest: basic-flip-after-cursor-atomic
[379.042222] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.915s)
[379.866122] [080/132] (641s left) gem_caching (read-writes)
[379.943441] Subtest read-writes: SKIP (0.000s)
[380.016466] [081/132] (641s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[380.114657] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[380.118598] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[380.213073] [082/132] (641s left) gem_exec_schedule (pi-common)
[380.389225] Starting subtest: pi-common
[380.391772] Starting dynamic subtest: rcs0
[380.413602] Dynamic subtest rcs0: SUCCESS (0.026s)
[380.427674] Starting dynamic subtest: bcs0
[380.441729] Dynamic subtest bcs0: SUCCESS (0.027s)
[380.455706] Starting dynamic subtest: vcs0
[380.468179] Dynamic subtest vcs0: SUCCESS (0.026s)
[380.480039] Starting dynamic subtest: vcs1
[380.495564] Dynamic subtest vcs1: SUCCESS (0.026s)
[380.509192] Starting dynamic subtest: vecs0
[380.522188] Dynamic subtest vecs0: SUCCESS (0.026s)
[380.534127] Starting dynamic subtest: ccs0
[380.550038] Dynamic subtest ccs0: SUCCESS (0.027s)
[380.552201] Subtest pi-common: SUCCESS (0.164s)
[380.773034] [083/132] (640s left) gem_exec_whisper (basic-sync-all)
[380.832259] Starting subtest: basic-sync-all
[388.658250] Subtest basic-sync-all: SUCCESS (7.821s)
[388.856919] [084/132] (632s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[388.924903] Starting subtest: invalid-bsd2-flag-on-blt
[388.927335] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[389.038112] [085/132] (632s left) gem_exec_balancer (full-late)
[389.110924] Starting subtest: full-late
[393.779051] Subtest full-late: SUCCESS (4.667s)
[394.097569] [086/132] (627s left) vgem_basic (bad-handle)
[394.140859] Starting subtest: bad-handle
[394.143084] Subtest bad-handle: SUCCESS (0.000s)
[394.207193] [087/132] (627s left) kms_3d (basic)
[394.252827] Starting subtest: basic
[396.217253] Subtest basic: SUCCESS (1.966s)
[396.708258] [088/132] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[396.807624] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[396.811788] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[396.908564] [089/132] (624s left) kms_vblank (wait-forked-busy-hang)
[396.992924] Starting subtest: wait-forked-busy-hang
[396.995247] Starting dynamic subtest: pipe-A-eDP-1
[423.712035] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.712s)
[423.727380] Starting dynamic subtest: pipe-D-eDP-1
[448.749186] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.041s)
[448.751337] Subtest wait-forked-busy-hang: SUCCESS (51.757s)
[449.582571] [090/132] (572s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[449.642694] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[449.644854] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[449.740080] [091/132] (572s left) i915_query (test-query-geometry-subslices)
[449.795316] Starting subtest: test-query-geometry-subslices
[449.797488] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[449.892108] [092/132] (572s left) gem_exec_parallel (engines)
[449.951094] Starting subtest: engines
[449.953417] Starting dynamic subtest: basic
[451.938451] Dynamic subtest basic: SUCCESS (1.985s)
[451.949725] Starting dynamic subtest: contexts
[456.416181] Dynamic subtest contexts: SUCCESS (4.475s)
[456.428879] Starting dynamic subtest: fds
[460.278527] Dynamic subtest fds: SUCCESS (3.861s)
[460.288142] Starting dynamic subtest: userptr
[462.016411] Dynamic subtest userptr: SUCCESS (1.737s)
[462.018319] Subtest engines: SUCCESS (12.066s)
[462.212558] [093/132] (559s left) kms_cursor_crc (cursor-random-256x256)
[462.459412] Starting subtest: cursor-random-256x256
[462.464305] Starting dynamic subtest: pipe-A-eDP-1
[465.820289] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.356s)
[465.852751] Starting dynamic subtest: pipe-D-eDP-1
[469.871235] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.026s)
[469.873485] Subtest cursor-random-256x256: SUCCESS (7.411s)
[470.698956] [094/132] (551s left) i915_hangman (engine-error-state-capture)
[470.758753] Starting subtest: engine-error-state-capture
[470.761110] Starting dynamic subtest: rcs0
[473.920581] Dynamic subtest rcs0: SUCCESS (3.160s)
[473.933063] Starting dynamic subtest: bcs0
[479.937088] Dynamic subtest bcs0: SUCCESS (6.013s)
[479.950224] Starting dynamic subtest: vcs0
[485.887737] Dynamic subtest vcs0: SUCCESS (5.948s)
[485.900574] Starting dynamic subtest: vcs1
[490.880262] Dynamic subtest vcs1: SUCCESS (4.989s)
[490.893489] Starting dynamic subtest: vecs0
[495.872343] Dynamic subtest vecs0: SUCCESS (4.989s)
[495.885387] Starting dynamic subtest: ccs0
[500.928786] Dynamic subtest ccs0: SUCCESS (5.053s)
[500.931604] Subtest engine-error-state-capture: SUCCESS (30.168s)
[501.012000] [095/132] (521s left) kms_flip (flip-vs-absolute-wf_vblank)
[501.125962] Starting subtest: flip-vs-absolute-wf_vblank
[501.128353] Starting dynamic subtest: A-eDP1
[510.008458] Dynamic subtest A-eDP1: SUCCESS (8.885s)
[510.018056] Starting dynamic subtest: B-eDP1
[518.892467] Dynamic subtest B-eDP1: SUCCESS (8.882s)
[518.901782] Starting dynamic subtest: C-eDP1
[527.836139] Dynamic subtest C-eDP1: SUCCESS (8.894s)
[527.846368] Starting dynamic subtest: D-eDP1
[536.732432] Dynamic subtest D-eDP1: SUCCESS (8.889s)
[536.734634] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.562s)
[537.890743] [096/132] (484s left) gem_softpin (evict-snoop-interruptible)
[537.949947] Starting subtest: evict-snoop-interruptible
[537.954498] Subtest evict-snoop-interruptible: SKIP (0.000s)
[538.089368] [097/132] (484s left) gem_mmap (bad-size)
[538.149467] Subtest bad-size: SKIP (0.000s)
[538.209900] [098/132] (484s left) perf_pmu (busy-idle-no-semaphores)
[538.253311] Starting subtest: busy-idle-no-semaphores
[538.255630] Starting dynamic subtest: rcs0
[538.920760] Dynamic subtest rcs0: SUCCESS (0.665s)
[538.934248] Starting dynamic subtest: bcs0
[539.572410] Dynamic subtest bcs0: SUCCESS (0.647s)
[539.585551] Starting dynamic subtest: vcs0
[540.243626] Dynamic subtest vcs0: SUCCESS (0.648s)
[540.253216] Starting dynamic subtest: vcs1
[541.579901] Dynamic subtest vcs1: SUCCESS (1.355s)
[541.592679] Starting dynamic subtest: vecs0
[543.563102] Dynamic subtest vecs0: SUCCESS (1.981s)
[543.576091] Starting dynamic subtest: ccs0
[545.547099] Dynamic subtest ccs0: SUCCESS (1.981s)
[545.550184] Subtest busy-idle-no-semaphores: SUCCESS (7.292s)
[545.675252] [099/132] (476s left) kms_psr (fbc-pr-primary-render)
[545.776416] Starting subtest: fbc-pr-primary-render
[545.780798] Subtest fbc-pr-primary-render: SKIP (0.000s)
[545.852934] [100/132] (476s left) kms_getfb (getfb-handle-zero)
[545.937419] Starting subtest: getfb-handle-zero
[545.939658] Subtest getfb-handle-zero: SUCCESS (0.000s)
[546.059553] [101/132] (476s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[546.121617] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[546.125933] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[546.319231] [102/132] (476s left) gem_pxp (verify-pxp-stale-buf-execution)
[546.452789] Starting subtest: verify-pxp-stale-buf-execution
[547.513203] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[547.632958] [103/132] (474s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[547.739013] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[548.575257] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[548.737628] [104/132] (473s left) perf (polling)
[548.823761] Starting subtest: polling
[548.826146] Starting dynamic subtest: 0-rcs0
[558.892680] Dynamic subtest 0-rcs0: SUCCESS (10.014s)
[558.905041] Starting dynamic subtest: 1-vcs1
[568.916735] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[568.919196] Subtest polling: SUCCESS (20.037s)
[568.959841] [105/132] (453s left) kms_chamelium_color (ctm-0-25)
[569.067116] Subtest ctm-0-25: SKIP (0.000s)
[569.113696] [106/132] (453s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[569.204999] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[569.209147] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[569.279856] [107/132] (453s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[569.384867] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[569.389265] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[569.487622] [108/132] (453s left) gem_partial_pwrite_pread (reads-snoop)
[569.544901] Subtest reads-snoop: SKIP (0.000s)
[569.619585] [109/132] (453s left) kms_plane_scaling (planes-downscale-factor-0-75)
[569.716589] Starting subtest: planes-downscale-factor-0-75
[569.718829] Starting dynamic subtest: pipe-A
[569.739055] Dynamic subtest pipe-A: SKIP (0.020s)
[569.749566] Starting dynamic subtest: pipe-B
[569.774098] Dynamic subtest pipe-B: SKIP (0.035s)
[569.783857] Starting dynamic subtest: pipe-C
[569.811873] Dynamic subtest pipe-C: SKIP (0.035s)
[569.821702] Starting dynamic subtest: pipe-D
[569.844821] Dynamic subtest pipe-D: SKIP (0.033s)
[569.848502] Subtest planes-downscale-factor-0-75: SKIP (0.126s)
[569.952569] [110/132] (452s left) gem_mmap_offset (blt-coherency)
[570.012917] Starting subtest: blt-coherency
[570.018658] Subtest blt-coherency: SUCCESS (0.007s)
[570.155127] [111/132] (452s left) kms_prop_blob (blob-prop-lifetime)
[570.211587] Starting subtest: blob-prop-lifetime
[570.213603] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[570.312884] [112/132] (452s left) gem_create (create-ext-placement-all)
[570.487121] Starting subtest: create-ext-placement-all
[570.490020] Subtest create-ext-placement-all: SUCCESS (0.000s)
[570.603932] [113/132] (452s left) syncobj_timeline (wait-all-for-submit-snapshot)
[570.666142] Starting subtest: wait-all-for-submit-snapshot
[570.746367] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[570.825672] [114/132] (452s left) kms_invalid_mode (zero-clock)
[570.922833] Starting subtest: zero-clock
[570.925074] Starting dynamic subtest: pipe-A-eDP-1
[571.203581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[571.213638] Starting dynamic subtest: pipe-B-eDP-1
[571.215588] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[571.224909] Starting dynamic subtest: pipe-C-eDP-1
[571.227288] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[571.236776] Starting dynamic subtest: pipe-D-eDP-1
[571.239016] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[571.241264] Subtest zero-clock: SUCCESS (0.290s)
[572.084732] [115/132] (450s left) kms_getfb (getfb-reject-nv12)
[572.182406] Starting subtest: getfb-reject-nv12
[572.184598] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[572.286005] [116/132] (450s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[572.379331] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[572.381647] Starting dynamic subtest: pipe-A-default-mode
[575.082943] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s)
[575.085276] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.705s)
[575.885448] [117/132] (447s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[575.941344] Starting subtest: etime-multi-wait-all-for-submit-submitted
[576.046879] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[576.136558] [118/132] (447s left) gem_softpin (full)
[576.194378] Starting subtest: full
[576.202746] Subtest full: SUCCESS (0.008s)
[576.333329] [119/132] (446s left) kms_atomic (atomic-plane-damage)
[576.434143] Starting subtest: atomic-plane-damage
[576.484541] Starting dynamic subtest: pipe-A-eDP-1
[577.057782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[577.060061] Subtest atomic-plane-damage: SUCCESS (0.625s)
[577.888446] [120/132] (445s left) gem_exec_whisper (basic-contexts-all)
[577.954877] Starting subtest: basic-contexts-all
[588.932708] Subtest basic-contexts-all: SUCCESS (10.971s)
[589.119092] [121/132] (434s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[589.183753] Starting subtest: invalid-bsd1-flag-on-vebox
[589.186115] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[589.278853] [122/132] (434s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[589.382746] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[589.387070] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[589.475387] [123/132] (433s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[589.597788] Starting subtest: cursor-vs-flip-atomic
[618.962397] Subtest cursor-vs-flip-atomic: SUCCESS (29.359s)
[619.797299] [124/132] (403s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[619.923819] Starting subtest: cursorA-vs-flipA-toggle
[631.066810] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.140s)
[631.916678] [125/132] (391s left) gen7_exec_parse (oacontrol-tracking)
[631.993221] Subtest oacontrol-tracking: SKIP (0.000s)
[632.053699] [126/132] (391s left) kms_content_protection (atomic-dpms)
[632.195865] Starting subtest: atomic-dpms
[632.200441] Subtest atomic-dpms: SKIP (0.000s)
[632.335959] [127/132] (391s left) gem_mmap_wc (invalid-flags)
[632.390991] Subtest invalid-flags: SKIP (0.000s)
[632.445104] [128/132] (391s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[632.540379] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[632.544539] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[632.638838] [129/132] (391s left) kms_legacy_colorkey (basic)
[632.723385] Starting subtest: basic
[632.725592] Starting dynamic subtest: pipe-A
[632.767466] Dynamic subtest pipe-A: SUCCESS (0.045s)
[632.780086] Starting dynamic subtest: pipe-B
[632.782368] Dynamic subtest pipe-B: SUCCESS (0.001s)
[632.791737] Starting dynamic subtest: pipe-C
[632.793576] Dynamic subtest pipe-C: SUCCESS (0.000s)
[632.802426] Starting dynamic subtest: pipe-D
[632.804373] Dynamic subtest pipe-D: SUCCESS (0.000s)
[632.806290] Subtest basic: SUCCESS (0.051s)
[632.844754] [130/132] (390s left) kms_psr (psr-primary-mmap-gtt)
[632.935628] Starting subtest: psr-primary-mmap-gtt
[632.937422] Starting dynamic subtest: eDP-1
[634.356978] Dynamic subtest eDP-1: SKIP (1.417s)
[634.361774] Subtest psr-primary-mmap-gtt: SKIP (1.419s)
[634.518342] [131/132] (389s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[634.622322] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[634.624616] Starting dynamic subtest: pipe-A-eDP-1
[634.647629] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[634.659458] Starting dynamic subtest: pipe-B-eDP-1
[634.681787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[634.691008] Starting dynamic subtest: pipe-C-eDP-1
[634.713863] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[634.723845] Starting dynamic subtest: pipe-D-eDP-1
[634.746084] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[634.750244] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[636.902119] [132/132] (386s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[636.999482] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[637.003970] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[638.092709] Closing watchdogs
results: parsing output: 0/ for test: core_setmaster
results: parsing output: 1/ for test: gem_sync
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_color_pipeline
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_vrr
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: syncobj_basic
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_ctx_param
results: parsing output: 12/ for test: gem_gtt_cpu_tlb
results: parsing output: 13/ for test: kms_pipe_crc_basic
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: i915_pm_rc6_residency
results: parsing output: 20/ for test: gem_ctx_shared
results: parsing output: 21/ for test: api_intel_bb
results: parsing output: 22/ for test: gem_partial_pwrite_pread
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_ctx_isolation
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: gem_wait
results: parsing output: 35/ for test: syncobj_basic
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: gem_ppgtt
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: kms_chamelium_hpd
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_draw_crc
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: core_auth
results: parsing output: 48/ for test: kms_sequence
results: parsing output: 49/ for test: kms_busy
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: i915_drm_fdinfo
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: fbdev
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_pipe_b_c_ivb
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: kms_chamelium_edid
results: parsing output: 75/ for test: kms_fb_coherency
results: parsing output: 76/ for test: kms_rmfb
results: parsing output: 77/ for test: gem_exec_basic
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_caching
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: vgem_basic
results: parsing output: 86/ for test: kms_3d
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_vblank
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: i915_query
results: parsing output: 91/ for test: gem_exec_parallel
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: i915_hangman
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: gem_mmap
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_getfb
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: kms_chamelium_color
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_partial_pwrite_pread
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: kms_prop_blob
results: parsing output: 111/ for test: gem_create
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_invalid_mode
results: parsing output: 114/ for test: kms_getfb
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_softpin
results: parsing output: 118/ for test: kms_atomic
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gen7_exec_parse
results: parsing output: 125/ for test: kms_content_protection
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_legacy_colorkey
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_ccs
Done.