[63.701882] Initializing watchdogs
[63.701930]   /dev/watchdog0
[63.716691] [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]
[63.721583] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.723854] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.727210] [001/133] (960s left) kms_psr (psr2-sprite-render)
[63.848842] Starting subtest: psr2-sprite-render
[63.851137] Starting dynamic subtest: eDP-1
[65.628634] Dynamic subtest eDP-1: SUCCESS (1.771s)
[65.630650] Subtest psr2-sprite-render: SUCCESS (1.772s)
[66.494684] [002/133] (957s left) kms_cursor_crc (cursor-onscreen-64x21)
[66.692848] Starting subtest: cursor-onscreen-64x21
[66.745225] Subtest cursor-onscreen-64x21: SKIP (0.048s)
[67.107512] [003/133] (957s left) perf_pmu (busy-accuracy-50)
[67.192717] Starting subtest: busy-accuracy-50
[67.195175] Starting dynamic subtest: rcs0
[68.732439] Dynamic subtest rcs0: SUCCESS (1.533s)
[68.743141] Starting dynamic subtest: bcs0
[70.274998] Dynamic subtest bcs0: SUCCESS (1.538s)
[70.282667] Starting dynamic subtest: vcs0
[71.815990] Dynamic subtest vcs0: SUCCESS (1.537s)
[71.826444] Starting dynamic subtest: vcs1
[73.359539] Dynamic subtest vcs1: SUCCESS (1.540s)
[73.366888] Starting dynamic subtest: vecs0
[74.902054] Dynamic subtest vecs0: SUCCESS (1.540s)
[74.912898] Starting dynamic subtest: ccs0
[76.449246] Dynamic subtest ccs0: SUCCESS (1.544s)
[76.451702] Subtest busy-accuracy-50: SUCCESS (9.237s)
[76.561802] [004/133] (947s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[76.658102] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[76.660509] Starting dynamic subtest: pipe-A-eDP-1
[76.778021] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[76.787657] Starting dynamic subtest: pipe-B-eDP-1
[77.994051] Dynamic subtest pipe-B-eDP-1: SKIP (1.212s)
[77.998689] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.336s)
[79.191215] [005/133] (945s left) gem_ctx_create (basic)
[79.254896] Starting subtest: basic
[79.257049] Subtest basic: SUCCESS (0.000s)
[79.432546] [006/133] (945s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[79.513524] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[79.518287] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[79.600632] [007/133] (944s left) gem_render_copy (linear-to-vebox-yf-tiled)
[79.656071] Starting subtest: linear-to-vebox-yf-tiled
[79.660427] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[79.851107] [008/133] (944s left) syncobj_wait (wait-all-for-submit-complex)
[79.910288] Starting subtest: wait-all-for-submit-complex
[80.125316] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[80.209970] [009/133] (944s left) prime_vgem (wait)
[80.327113] Starting subtest: wait
[80.329513] Starting dynamic subtest: rcs0
[80.365320] Dynamic subtest rcs0: SUCCESS (0.038s)
[80.373108] Starting dynamic subtest: bcs0
[80.416800] Dynamic subtest bcs0: SUCCESS (0.050s)
[80.424892] Starting dynamic subtest: vcs0
[80.463479] Dynamic subtest vcs0: SUCCESS (0.047s)
[80.471164] Starting dynamic subtest: vcs1
[80.508926] Dynamic subtest vcs1: SUCCESS (0.045s)
[80.516712] Starting dynamic subtest: vecs0
[80.554818] Dynamic subtest vecs0: SUCCESS (0.046s)
[80.563027] Starting dynamic subtest: ccs0
[80.601684] Dynamic subtest ccs0: SUCCESS (0.046s)
[80.604103] Subtest wait: SUCCESS (0.275s)
[80.734114] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[80.737059] [010/133] (943s left) gem_readwrite (write-bad-handle)
[80.798228] Subtest write-bad-handle: SKIP (0.000s)
[80.861629] [011/133] (943s left) syncobj_timeline (wait-for-submit-delayed-submit)
[80.917802] Starting subtest: wait-for-submit-delayed-submit
[81.023891] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[81.098587] [012/133] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[81.200903] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[81.205304] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[81.306631] [013/133] (943s left) gem_fenced_exec_thrash (2-spare-fences)
[81.369939] Subtest 2-spare-fences: SKIP (0.000s)
[81.436138] [014/133] (943s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[81.543371] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[88.212887] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.667s)
[88.325350] [015/133] (936s left) gem_busy (semaphore)
[88.516165] Subtest semaphore: SKIP (0.000s)
[88.747863] [016/133] (936s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[88.846925] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[90.081747] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.234s)
[90.181290] [017/133] (934s left) perf_pmu (render-node-busy-idle)
[90.251601] Starting subtest: render-node-busy-idle
[90.253503] Starting dynamic subtest: rcs0
[90.965659] Dynamic subtest rcs0: SUCCESS (0.713s)
[90.976415] Starting dynamic subtest: bcs0
[91.628646] Dynamic subtest bcs0: SUCCESS (0.662s)
[91.639276] Starting dynamic subtest: vcs0
[92.885633] Dynamic subtest vcs0: SUCCESS (1.254s)
[92.896722] Starting dynamic subtest: vcs1
[94.932575] Dynamic subtest vcs1: SUCCESS (2.045s)
[94.941984] Starting dynamic subtest: vecs0
[96.916598] Dynamic subtest vecs0: SUCCESS (1.982s)
[96.927621] Starting dynamic subtest: ccs0
[97.580632] Dynamic subtest ccs0: SUCCESS (0.664s)
[97.583611] Subtest render-node-busy-idle: SUCCESS (7.324s)
[97.661665] [018/133] (927s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[97.758692] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[97.760983] Starting dynamic subtest: pipe-A-default-mode
[100.484558] Dynamic subtest pipe-A-default-mode: SUCCESS (2.723s)
[100.486899] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.724s)
[101.342119] [019/133] (923s left) gen9_exec_parse (batch-invalid-length)
[101.404333] Subtest batch-invalid-length: SKIP (0.000s)
[101.476431] [020/133] (923s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[101.570902] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[101.573293] Starting dynamic subtest: A-eDP1
[105.185294] Dynamic subtest A-eDP1: SUCCESS (3.610s)
[105.200087] Starting dynamic subtest: B-eDP1
[108.413425] Dynamic subtest B-eDP1: SUCCESS (3.226s)
[108.422016] Starting dynamic subtest: C-eDP1
[111.596059] Dynamic subtest C-eDP1: SUCCESS (3.181s)
[111.606463] Starting dynamic subtest: D-eDP1
[114.705070] Dynamic subtest D-eDP1: SUCCESS (3.108s)
[114.707462] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.132s)
[115.511952] [021/133] (909s left) kms_pm_rpm (i2c)
[117.047289] Starting subtest: i2c
[122.724493] Subtest i2c: SUCCESS (5.678s)
[122.814659] [022/133] (902s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[122.871651] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[122.873824] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[122.964126] [023/133] (902s left) gem_reg_read (bad-register)
[123.025023] Starting subtest: bad-register
[123.027240] Subtest bad-register: SUCCESS (0.000s)
[123.115771] [024/133] (902s left) syncobj_wait (multi-wait-for-submit-signaled)
[123.167683] Starting subtest: multi-wait-for-submit-signaled
[123.169965] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[123.266702] [025/133] (901s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[123.328699] Starting subtest: yf-tiled-to-vebox-x-tiled
[123.333071] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[123.510124] [026/133] (901s left) gem_userptr_blits (probe)
[123.589365] Starting subtest: probe
[123.668332] Subtest probe: SUCCESS (0.079s)
[123.798239] [027/133] (901s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[123.906535] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[130.797722] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.890s)
[130.939301] [028/133] (894s left) gem_exec_balancer (bonded-chain)
[131.020387] Starting subtest: bonded-chain
[138.128047] Subtest bonded-chain: SUCCESS (7.107s)
[138.439437] [029/133] (886s left) kms_dp_link_training (non-uhbr-mst)
[138.548970] Starting subtest: non-uhbr-mst
[138.557842] Subtest non-uhbr-mst: SKIP (0.000s)
[138.620818] [030/133] (886s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[138.717458] Starting subtest: addfb25-y-tiled-small-legacy
[138.721964] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[138.822715] [031/133] (886s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[138.920665] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[138.924833] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[139.024919] [032/133] (886s left) kms_color_pipeline (plane-ctm3x4)
[139.114075] Starting subtest: plane-ctm3x4
[139.259598] Starting dynamic subtest: pipe-A-plane-0
[139.559803] Dynamic subtest pipe-A-plane-0: FAIL (0.158s)
[139.569318] Starting dynamic subtest: pipe-A-plane-1
[139.740653] Dynamic subtest pipe-A-plane-1: FAIL (0.139s)
[139.748113] Starting dynamic subtest: pipe-A-plane-2
[139.950543] Dynamic subtest pipe-A-plane-2: FAIL (0.155s)
[140.926561] Starting dynamic subtest: pipe-B-plane-0
[141.329321] Dynamic subtest pipe-B-plane-0: FAIL (0.142s)
[141.339622] Starting dynamic subtest: pipe-B-plane-1
[141.640648] Dynamic subtest pipe-B-plane-1: FAIL (0.155s)
[141.650453] Starting dynamic subtest: pipe-B-plane-2
[141.949307] Dynamic subtest pipe-B-plane-2: FAIL (0.154s)
[142.566320] Starting dynamic subtest: pipe-C-plane-0
[143.011067] Dynamic subtest pipe-C-plane-0: FAIL (0.118s)
[143.020652] Starting dynamic subtest: pipe-C-plane-1
[143.406240] Dynamic subtest pipe-C-plane-1: FAIL (0.121s)
[143.420859] Starting dynamic subtest: pipe-C-plane-2
[143.764247] Dynamic subtest pipe-C-plane-2: FAIL (0.601s)
[144.607402] Starting dynamic subtest: pipe-D-plane-0
[145.143200] Dynamic subtest pipe-D-plane-0: FAIL (0.112s)
[145.153377] Starting dynamic subtest: pipe-D-plane-1
[145.596102] Dynamic subtest pipe-D-plane-1: FAIL (0.578s)
[145.604526] Starting dynamic subtest: pipe-D-plane-2
[146.016580] Dynamic subtest pipe-D-plane-2: FAIL (0.539s)
[146.127831] Subtest plane-ctm3x4: FAIL (7.015s)
[146.956024] [033/133] (878s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[147.069886] Starting subtest: yf-tiled-8bpp-rotate-0
[147.074132] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[147.156945] [034/133] (878s left) gem_lmem_swapping (heavy-random)
[147.198932] Subtest heavy-random: SKIP (0.000s)
[147.245118] [035/133] (878s left) i915_hangman (error-state-basic)
[147.310509] Starting subtest: error-state-basic
[147.445052] Subtest error-state-basic: SUCCESS (0.133s)
[147.520440] [036/133] (878s left) i915_query (hwconfig_table)
[147.579749] Starting subtest: hwconfig_table
[147.877598] Subtest hwconfig_table: SUCCESS (0.001s)
[147.915894] [037/133] (877s left) gem_ctx_param (set-priority-invalid-size)
[147.965376] Starting subtest: set-priority-invalid-size
[147.967403] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[148.041162] [038/133] (877s left) kms_flip (2x-blocking-wf_vblank)
[148.151601] Starting subtest: 2x-blocking-wf_vblank
[148.161866] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[148.238610] [039/133] (877s left) gem_softpin (allocator-fork)
[148.292316] Starting subtest: allocator-fork
[150.501955] Subtest allocator-fork: SUCCESS (2.209s)
[150.616304] [040/133] (875s left) gem_exec_schedule (implicit-read-write)
[150.676415] Starting subtest: implicit-read-write
[150.678652] Starting dynamic subtest: rcs0
[150.869363] Dynamic subtest rcs0: SUCCESS (0.192s)
[150.881288] Starting dynamic subtest: vcs0
[150.973643] Dynamic subtest vcs0: SUCCESS (0.105s)
[150.984812] Starting dynamic subtest: vcs1
[151.084058] Dynamic subtest vcs1: SUCCESS (0.110s)
[151.098234] Starting dynamic subtest: vecs0
[151.187978] Dynamic subtest vecs0: SUCCESS (0.104s)
[151.200401] Starting dynamic subtest: ccs0
[151.307143] Dynamic subtest ccs0: SUCCESS (0.118s)
[151.309637] Subtest implicit-read-write: SUCCESS (0.631s)
[153.018714] [041/133] (872s left) kms_chamelium_color (degamma)
[153.119841] Subtest degamma: SKIP (0.000s)
[153.164384] [042/133] (872s left) kms_panel_fitting (atomic-fastset)
[153.256663] Starting subtest: atomic-fastset
[153.258548] Starting dynamic subtest: pipe-A-eDP-1
[153.418569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.163s)
[153.430057] Starting dynamic subtest: pipe-B-eDP-1
[154.615450] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.196s)
[154.626603] Starting dynamic subtest: pipe-C-eDP-1
[155.808702] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.191s)
[155.817796] Starting dynamic subtest: pipe-D-eDP-1
[156.989997] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.180s)
[156.992319] Subtest atomic-fastset: SUCCESS (3.735s)
[158.210940] [043/133] (867s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[158.315301] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[158.319661] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[158.396961] [044/133] (867s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[158.496601] Starting subtest: psr-rgb101010-draw-mmap-cpu
[165.591106] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.100s)
[165.704776] [045/133] (860s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[165.815060] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[165.817312] Starting dynamic subtest: pipe-A
[165.837925] Dynamic subtest pipe-A: SKIP (0.018s)
[165.846742] Starting dynamic subtest: pipe-B
[165.869229] Dynamic subtest pipe-B: SKIP (0.032s)
[165.879594] Starting dynamic subtest: pipe-C
[165.903727] Dynamic subtest pipe-C: SKIP (0.032s)
[165.916192] Starting dynamic subtest: pipe-D
[165.931828] Dynamic subtest pipe-D: SKIP (0.031s)
[165.935554] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.115s)
[166.029544] [046/133] (860s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[166.133276] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[170.286375] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.157s)
[171.448406] [047/133] (854s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[171.509089] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[171.571487] [048/133] (854s left) gem_partial_pwrite_pread (writes-after-reads-display)
[171.620373] Subtest writes-after-reads-display: SKIP (0.000s)
[171.691742] [049/133] (854s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[171.783067] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[171.785241] Starting dynamic subtest: pipe-A-eDP-1
[172.677025] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.888s)
[172.686093] Starting dynamic subtest: pipe-B-eDP-1
[174.402172] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.720s)
[174.412132] Starting dynamic subtest: pipe-C-eDP-1
[175.909716] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.507s)
[175.920095] Starting dynamic subtest: pipe-D-eDP-1
[177.422779] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.512s)
[177.425062] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.633s)
[178.577544] [050/133] (847s left) kms_frontbuffer_tracking (fbc-tiling-4)
[178.676931] Starting subtest: fbc-tiling-4
[182.901900] Subtest fbc-tiling-4: SUCCESS (4.229s)
[184.074934] [051/133] (842s left) gem_mmap_gtt (basic-small-copy-odd)
[184.127295] Subtest basic-small-copy-odd: SKIP (0.000s)
[184.188169] [052/133] (842s left) i915_query (query-topology-kernel-writes)
[184.247279] Starting subtest: query-topology-kernel-writes
[184.249169] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[184.346725] [053/133] (841s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[184.443203] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[184.445416] Starting dynamic subtest: pipe-A-eDP-1
[184.503900] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[184.513143] Starting dynamic subtest: pipe-B-eDP-1
[184.569469] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[184.579568] Starting dynamic subtest: pipe-C-eDP-1
[184.635601] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[184.645137] Starting dynamic subtest: pipe-D-eDP-1
[184.702202] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[184.706462] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[186.638116] [054/133] (839s left) kms_pipe_crc_basic (suspend-read-crc)
[186.725540] Starting subtest: suspend-read-crc
[186.727854] Starting dynamic subtest: pipe-A-eDP-1
[204.869050] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.118s)
[204.879150] Starting dynamic subtest: pipe-B-eDP-1
[223.858182] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.503s)
[223.867503] Starting dynamic subtest: pipe-C-eDP-1
[242.831506] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.437s)
[242.842531] Starting dynamic subtest: pipe-D-eDP-1
[261.826917] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.456s)
[261.829656] Subtest suspend-read-crc: SUCCESS (13.520s)
[270.675996] [055/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[270.780704] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[270.784870] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[270.864910] [056/133] (763s left) kms_plane_lowres (tiling-4)
[270.965102] Starting subtest: tiling-4
[270.967425] Starting dynamic subtest: pipe-A-eDP-1
[270.973530] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.269725] Starting dynamic subtest: pipe-B-eDP-1
[271.274308] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.283412] Starting dynamic subtest: pipe-C-eDP-1
[271.287926] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.297386] Starting dynamic subtest: pipe-D-eDP-1
[271.301986] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.306417] Subtest tiling-4: SKIP (0.294s)
[272.128148] [057/133] (762s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[272.219291] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[276.590030] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.252s)
[277.777962] [058/133] (756s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[277.885575] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[277.889947] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[277.991881] [059/133] (756s left) kms_hdr (static-toggle-suspend)
[278.086097] Starting subtest: static-toggle-suspend
[278.092362] Subtest static-toggle-suspend: SKIP (0.000s)
[278.159506] [060/133] (756s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[278.227513] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[278.287191] [061/133] (756s left) dmabuf_sync_file (import-basic)
[278.342267] Starting subtest: import-basic
[278.344627] Subtest import-basic: SUCCESS (0.002s)
[278.402703] [062/133] (756s left) i915_drm_fdinfo (busy-check-all)
[278.444875] Starting subtest: busy-check-all
[278.447005] Starting dynamic subtest: rcs0
[278.451930] Dynamic subtest rcs0: SKIP (0.004s)
[278.462240] Starting dynamic subtest: bcs0
[278.466685] Dynamic subtest bcs0: SKIP (0.000s)
[278.475108] Starting dynamic subtest: vcs0
[278.479638] Dynamic subtest vcs0: SKIP (0.000s)
[278.488463] Starting dynamic subtest: vcs1
[278.492894] Dynamic subtest vcs1: SKIP (0.000s)
[278.501694] Starting dynamic subtest: vecs0
[278.506147] Dynamic subtest vecs0: SKIP (0.000s)
[278.514712] Starting dynamic subtest: ccs0
[278.519164] Dynamic subtest ccs0: SKIP (0.000s)
[278.523546] Subtest busy-check-all: SKIP (0.010s)
[278.562260] [063/133] (756s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[278.974607] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[279.810464] [064/133] (755s left) kms_lease (empty-lease)
[279.903233] Starting subtest: empty-lease
[279.905610] Starting dynamic subtest: pipe-A-eDP-1
[279.907975] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[279.917743] Starting dynamic subtest: pipe-B-eDP-1
[279.920027] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[279.929155] Starting dynamic subtest: pipe-C-eDP-1
[279.931367] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[279.940423] Starting dynamic subtest: pipe-D-eDP-1
[279.942655] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[279.944892] Subtest empty-lease: SUCCESS (0.009s)
[280.022474] [065/133] (754s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[280.121329] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[280.133696] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[280.212824] [066/133] (754s left) gem_eio (wait-wedge-1us)
[280.437749] Starting subtest: wait-wedge-1us
[281.584328] Subtest wait-wedge-1us: SUCCESS (1.131s)
[281.715286] [067/133] (753s left) gem_mmap_gtt (hang)
[281.774291] Subtest hang: SKIP (0.000s)
[281.839836] [068/133] (753s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[281.945286] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[281.949637] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[282.057389] [069/133] (752s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[282.338711] Starting subtest: cursor-rapid-movement-512x512
[282.343014] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[282.518821] [070/133] (752s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[282.629196] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[282.631101] Starting dynamic subtest: pipe-A-eDP-1
[282.650879] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[282.661574] Starting dynamic subtest: pipe-B-eDP-1
[282.679310] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[282.687898] Starting dynamic subtest: pipe-C-eDP-1
[282.705844] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[282.714129] Starting dynamic subtest: pipe-D-eDP-1
[282.732534] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.736131] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[284.940654] [071/133] (750s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[285.037838] Starting subtest: 4-tiled-8bpp-rotate-270
[285.060149] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[285.165548] [072/133] (749s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[285.277843] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[288.978841] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.684s)
[290.151359] [073/133] (745s left) gem_exec_flush (basic-batch-kernel-default-wb)
[290.208012] Starting subtest: basic-batch-kernel-default-wb
[297.686710] Subtest basic-batch-kernel-default-wb: SUCCESS (7.459s)
[297.880518] [074/133] (737s left) gem_exec_alignment (many)
[297.950640] Starting subtest: many
[321.719080] Subtest many: SUCCESS (23.753s)
[324.453524] [075/133] (710s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[324.561523] Starting subtest: etime-single-wait-all-for-submit-submitted
[324.663342] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[324.742064] [076/133] (710s left) kms_vrr (flip-dpms)
[324.859732] Starting subtest: flip-dpms
[324.866074] Subtest flip-dpms: SKIP (0.000s)
[324.933982] [077/133] (710s left) kms_cursor_crc (cursor-sliding-32x10)
[325.092637] Starting subtest: cursor-sliding-32x10
[325.141235] Subtest cursor-sliding-32x10: SKIP (0.044s)
[325.417687] [078/133] (710s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[325.513859] Starting subtest: dsc-fractional-bpp-with-bpc
[325.543632] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[325.587668] [079/133] (709s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[325.685910] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[325.689533] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[325.786286] [080/133] (709s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[325.903454] Starting subtest: 2x-long-flip-vs-cursor-legacy
[325.907297] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[326.048537] [081/133] (709s left) perf_pmu (all-busy-check-all)
[326.093081] Starting subtest: all-busy-check-all
[327.459987] Subtest all-busy-check-all: SUCCESS (1.366s)
[327.554711] [082/133] (708s left) gem_mmap_offset (mmap-unmap)
[327.608412] Starting subtest: mmap-unmap
[327.610641] Starting dynamic subtest: smem0
[351.201262] Dynamic subtest smem0: SUCCESS (23.583s)
[351.203763] Subtest mmap-unmap: SUCCESS (23.584s)
[351.323352] [083/133] (684s left) kms_fbcon_fbt (psr-suspend)
[351.387440] Starting subtest: psr-suspend
[401.943694] Subtest psr-suspend: SUCCESS (21.228s)
[406.073453] [084/133] (633s left) gem_exec_params (secure-non-master)
[406.162626] Starting subtest: secure-non-master
[406.168318] Subtest secure-non-master: SKIP (0.000s)
[406.247314] [085/133] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[406.353238] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[413.299019] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.764s)
[413.413865] [086/133] (626s left) syncobj_timeline (wait-any-complex)
[413.475883] Starting subtest: wait-any-complex
[413.538112] Subtest wait-any-complex: SUCCESS (0.063s)
[413.624031] [087/133] (626s left) gem_exec_whisper (basic-fds-all)
[413.686482] Starting subtest: basic-fds-all
[423.989882] Subtest basic-fds-all: SUCCESS (10.209s)
[424.175659] [088/133] (615s left) prime_mmap (test_reprime)
[424.237468] Starting subtest: test_reprime
[424.239825] Starting dynamic subtest: test_reprime-smem
[424.269594] Dynamic subtest test_reprime-smem: SUCCESS (0.034s)
[424.272612] Subtest test_reprime: SUCCESS (0.034s)
[424.375341] [089/133] (615s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[424.466709] Starting subtest: multiplane-rotation-cropping-top
[442.023059] Subtest multiplane-rotation-cropping-top: SUCCESS (17.527s)
[442.133973] [090/133] (597s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[442.242052] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[442.246426] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[443.425016] [091/133] (596s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[443.526978] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[448.161000] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.638s)
[449.327574] [092/133] (590s left) kms_pm_dc (dc5-psr)
[450.434063] Starting subtest: dc5-psr
[453.354498] Subtest dc5-psr: SUCCESS (2.920s)
[454.163119] [093/133] (585s left) perf_pmu (interrupts)
[454.217699] Starting subtest: interrupts
[455.317744] Subtest interrupts: SUCCESS (1.101s)
[455.425025] [094/133] (584s left) kms_flip (dpms-off-confusion)
[455.514288] Starting subtest: dpms-off-confusion
[455.516788] Starting dynamic subtest: A-eDP1
[464.262752] Dynamic subtest A-eDP1: SUCCESS (8.747s)
[464.273837] Starting dynamic subtest: B-eDP1
[472.901590] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[472.911686] Starting dynamic subtest: C-eDP1
[481.532585] Dynamic subtest C-eDP1: SUCCESS (8.625s)
[481.542662] Starting dynamic subtest: D-eDP1
[490.166581] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[490.169336] Subtest dpms-off-confusion: SUCCESS (34.643s)
[491.341444] [095/133] (548s left) core_auth (getclient-simple)
[491.379806] Starting subtest: getclient-simple
[491.400805] Subtest getclient-simple: SUCCESS (0.020s)
[491.497059] [096/133] (548s left) kms_big_fb (linear-8bpp-rotate-180)
[491.604208] Starting subtest: linear-8bpp-rotate-180
[492.909737] Subtest linear-8bpp-rotate-180: SUCCESS (1.307s)
[493.014150] [097/133] (547s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[493.579482] Starting subtest: syncobj-timeline-invalid-flags
[493.582157] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[494.856002] [098/133] (545s left) kms_atomic (crtc-invalid-params)
[494.951641] Starting subtest: crtc-invalid-params
[494.954429] Starting dynamic subtest: pipe-A-eDP-1
[495.308517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s)
[495.311301] Subtest crtc-invalid-params: SUCCESS (0.359s)
[496.182432] [099/133] (544s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[496.280347] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[497.382435] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.102s)
[497.494078] [100/133] (542s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[497.587340] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[497.591853] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[497.680080] [101/133] (542s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[497.822530] Starting subtest: dp-mst-type-1-suspend-resume
[497.827396] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[497.948239] [102/133] (542s left) gem_exec_schedule (promotion)
[498.020202] Starting subtest: promotion
[498.022054] Starting dynamic subtest: rcs0
[498.129337] Dynamic subtest rcs0: SUCCESS (0.116s)
[498.141459] Starting dynamic subtest: vcs0
[498.221120] Dynamic subtest vcs0: SUCCESS (0.091s)
[498.232558] Starting dynamic subtest: vcs1
[498.311668] Dynamic subtest vcs1: SUCCESS (0.090s)
[498.324198] Starting dynamic subtest: vecs0
[498.397674] Dynamic subtest vecs0: SUCCESS (0.085s)
[498.409964] Starting dynamic subtest: ccs0
[498.494618] Dynamic subtest ccs0: SUCCESS (0.095s)
[498.497374] Subtest promotion: SUCCESS (0.482s)
[499.894353] [103/133] (540s left) gem_exec_fence (basic-await)
[500.075309] Starting subtest: basic-await
[500.078273] Starting dynamic subtest: rcs0
[500.151029] Dynamic subtest rcs0: SUCCESS (0.076s)
[500.163624] Starting dynamic subtest: bcs0
[500.226597] Dynamic subtest bcs0: SUCCESS (0.073s)
[500.238821] Starting dynamic subtest: vcs0
[500.303921] Dynamic subtest vcs0: SUCCESS (0.076s)
[500.315738] Starting dynamic subtest: vcs1
[500.381492] Dynamic subtest vcs1: SUCCESS (0.076s)
[500.393975] Starting dynamic subtest: vecs0
[500.455383] Dynamic subtest vecs0: SUCCESS (0.072s)
[500.468137] Starting dynamic subtest: ccs0
[500.532479] Dynamic subtest ccs0: SUCCESS (0.075s)
[500.535303] Subtest basic-await: SUCCESS (0.458s)
[501.897047] [104/133] (538s left) gem_exec_fence (syncobj-wait)
[502.334681] Starting subtest: syncobj-wait
[503.823938] Subtest syncobj-wait: SUCCESS (1.491s)
[505.904588] [105/133] (534s left) kms_psr (pr-cursor-blt)
[506.013643] Starting subtest: pr-cursor-blt
[506.018603] Subtest pr-cursor-blt: SKIP (0.000s)
[506.086215] [106/133] (534s left) kms_atomic_transition (plane-all-transition-fencing)
[506.172701] Starting subtest: plane-all-transition-fencing
[506.175511] Starting dynamic subtest: pipe-A-eDP-1
[508.665609] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[508.978621] Starting dynamic subtest: pipe-B-eDP-1
[512.219052] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.250s)
[512.530725] Subtest plane-all-transition-fencing: SUCCESS (6.359s)
[513.353251] [107/133] (527s left) gem_create (create-massive)
[513.409430] Starting subtest: create-massive
[513.411835] Subtest create-massive: SUCCESS (0.000s)
[513.599247] [108/133] (527s left) gem_mmap (basic)
[513.663733] Subtest basic: SKIP (0.000s)
[513.724090] [109/133] (527s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[513.811565] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[513.816384] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[513.890190] [110/133] (526s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[513.981790] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[520.658657] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.682s)
[520.760516] [111/133] (520s left) gem_mmap_wc (write-prefaulted)
[520.818525] Subtest write-prefaulted: SKIP (0.000s)
[520.876222] [112/133] (520s left) gem_fenced_exec_thrash (too-many-fences)
[520.946133] Subtest too-many-fences: SKIP (0.000s)
[521.016551] [113/133] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[521.112574] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[521.117685] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[521.209540] [114/133] (519s left) gem_mmap_gtt (basic-read-write-distinct)
[521.268765] Subtest basic-read-write-distinct: SKIP (0.000s)
[521.330325] [115/133] (519s left) kms_prop_blob (invalid-set-prop-any)
[521.383229] Starting subtest: invalid-set-prop-any
[521.385708] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[521.467231] [116/133] (519s left) gem_exec_params (no-vebox)
[521.515275] Starting subtest: no-vebox
[521.520311] Subtest no-vebox: SUCCESS (0.004s)
[522.847496] [117/133] (518s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[522.964478] Starting subtest: flip-vs-cursor-crc-legacy
[523.658719] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.691s)
[524.479429] [118/133] (516s left) gem_ctx_isolation (dirty-create)
[524.538322] Starting subtest: dirty-create
[524.540629] Starting dynamic subtest: rcs0
[524.705620] Dynamic subtest rcs0: SUCCESS (0.167s)
[524.717474] Starting dynamic subtest: bcs0
[524.919660] Dynamic subtest bcs0: SUCCESS (0.213s)
[524.930670] Starting dynamic subtest: vcs0
[525.124729] Dynamic subtest vcs0: SUCCESS (0.203s)
[525.136873] Starting dynamic subtest: vcs1
[527.013041] Dynamic subtest vcs1: SUCCESS (1.888s)
[527.024816] Starting dynamic subtest: vecs0
[529.021353] Dynamic subtest vecs0: SUCCESS (2.008s)
[529.035925] Starting dynamic subtest: ccs0
[531.009441] Dynamic subtest ccs0: SUCCESS (1.984s)
[531.012609] Subtest dirty-create: SUCCESS (6.471s)
[531.241982] [119/133] (509s left) api_intel_allocator (reloc-allocator)
[531.308470] Starting subtest: reloc-allocator
[531.311019] Starting dynamic subtest: basic
[531.313723] Dynamic subtest basic: SUCCESS (0.006s)
[531.325492] Starting dynamic subtest: parallel-one
[531.327725] Dynamic subtest parallel-one: SUCCESS (0.009s)
[531.338128] Starting dynamic subtest: print
[531.340863] Dynamic subtest print: SUCCESS (0.000s)
[531.350531] Starting dynamic subtest: reuse
[531.353238] Dynamic subtest reuse: SUCCESS (0.000s)
[531.363079] Starting dynamic subtest: fork-reopen-allocator
[531.365477] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[531.367847] Subtest reloc-allocator: SUCCESS (0.032s)
[531.474390] [120/133] (509s left) kms_scaling_modes (scaling-mode-none)
[531.572682] Starting subtest: scaling-mode-none
[531.575491] Starting dynamic subtest: pipe-A-eDP-1
[531.671003] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s)
[531.683572] Starting dynamic subtest: pipe-B-eDP-1
[531.707852] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s)
[531.718418] Starting dynamic subtest: pipe-C-eDP-1
[531.744315] Dynamic subtest pipe-C-eDP-1: SKIP (0.035s)
[531.754959] Starting dynamic subtest: pipe-D-eDP-1
[531.779682] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s)
[531.784682] Subtest scaling-mode-none: SKIP (0.207s)
[531.885308] [121/133] (509s left) syncobj_eventfd (invalid-illegal-eventfd)
[531.941068] Starting subtest: invalid-illegal-eventfd
[531.943519] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[532.038227] [122/133] (509s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[532.146954] Starting subtest: fbc-pr-sprite-mmap-gtt
[532.151625] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[532.219550] [123/133] (509s left) gem_exec_reloc (basic-cpu-read-active)
[532.281665] Subtest basic-cpu-read-active: SKIP (0.000s)
[532.357212] [124/133] (509s left) kms_psr (fbc-psr-sprite-blt)
[532.452608] Starting subtest: fbc-psr-sprite-blt
[532.454802] Starting dynamic subtest: eDP-1
[532.459078] Dynamic subtest eDP-1: SKIP (0.000s)
[532.463055] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[532.526288] [125/133] (508s left) kms_flip (bo-too-big-interruptible)
[532.618698] Starting subtest: bo-too-big-interruptible
[532.621126] Starting dynamic subtest: A-eDP1
[533.924991] Dynamic subtest A-eDP1: SUCCESS (1.305s)
[533.938388] Starting dynamic subtest: B-eDP1
[535.162554] Dynamic subtest B-eDP1: SUCCESS (1.237s)
[535.172635] Starting dynamic subtest: C-eDP1
[536.500223] Dynamic subtest C-eDP1: SUCCESS (1.335s)
[536.510846] Starting dynamic subtest: D-eDP1
[537.740128] Dynamic subtest D-eDP1: SUCCESS (1.239s)
[537.742501] Subtest bo-too-big-interruptible: SUCCESS (5.124s)
[538.947785] [126/133] (502s left) gem_ctx_persistence (legacy-engines-cleanup)
[539.007624] Starting subtest: legacy-engines-cleanup
[539.010065] Starting dynamic subtest: render
[539.075076] Dynamic subtest render: SUCCESS (0.070s)
[539.087603] Starting dynamic subtest: bsd1
[539.112003] Dynamic subtest bsd1: SUCCESS (0.034s)
[539.128047] Starting dynamic subtest: bsd2
[539.149931] Dynamic subtest bsd2: SUCCESS (0.035s)
[539.169972] Starting dynamic subtest: blt
[539.196067] Dynamic subtest blt: SUCCESS (0.042s)
[539.206539] Starting dynamic subtest: vebox
[539.239154] Dynamic subtest vebox: SUCCESS (0.040s)
[539.242055] Subtest legacy-engines-cleanup: SUCCESS (0.236s)
[539.325923] [127/133] (502s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[539.383649] Starting subtest: multi-wait-all-available-submitted-signaled
[539.386492] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[539.486231] [128/133] (502s left) kms_chamelium_color (ctm-max)
[539.583266] Subtest ctm-max: SKIP (0.000s)
[539.631703] [129/133] (502s left) i915_pm_rpm (gem-pread)
[541.157750] Starting subtest: gem-pread
[543.549627] Subtest gem-pread: SUCCESS (2.390s)
[543.644946] [130/133] (498s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[543.748851] Starting subtest: psr2-plane-move-sf-dmg-area
[543.751761] Starting dynamic subtest: pipe-A-eDP-1
[548.267793] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.525s)
[548.279412] Starting dynamic subtest: pipe-B-eDP-1
[553.601228] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.331s)
[553.604158] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.860s)
[554.480199] [131/133] (487s left) kms_plane (plane-panning-top-left)
[554.570263] Starting subtest: plane-panning-top-left
[554.572493] Starting dynamic subtest: pipe-A
[556.262254] Dynamic subtest pipe-A: SUCCESS (1.693s)
[556.272814] Starting dynamic subtest: pipe-B
[558.698239] Dynamic subtest pipe-B: SUCCESS (2.431s)
[558.700642] Subtest plane-panning-top-left: SUCCESS (4.127s)
[559.497666] [132/133] (482s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[559.600852] Starting subtest: y-tiled-64bpp-rotate-270
[559.605761] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[559.697760] [133/133] (482s left) perf (i915-ref-count)
[559.781119] Starting subtest: i915-ref-count
[559.851529] Subtest i915-ref-count: SUCCESS (0.071s)
[559.917226] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: gem_ctx_create
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: prime_vgem
results: parsing output: 9/ for test: gem_readwrite
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_fenced_exec_thrash
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_busy
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: gen9_exec_parse
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_reg_read
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_dp_link_training
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_color_pipeline
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: i915_hangman
results: parsing output: 35/ for test: i915_query
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_chamelium_color
results: parsing output: 41/ for test: kms_panel_fitting
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: gem_partial_pwrite_pread
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: i915_query
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_pipe_crc_basic
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane_lowres
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_hdr
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: dmabuf_sync_file
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_flush
results: parsing output: 73/ for test: gem_exec_alignment
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_dsc
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: kms_fbcon_fbt
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: prime_mmap
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_pm_dc
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: core_auth
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: kms_atomic
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: gem_mmap
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_mmap_wc
results: parsing output: 111/ for test: gem_fenced_exec_thrash
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_prop_blob
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: gem_ctx_isolation
results: parsing output: 118/ for test: api_intel_allocator
results: parsing output: 119/ for test: kms_scaling_modes
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_chamelium_color
results: parsing output: 128/ for test: i915_pm_rpm
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: perf
Done.