[63.591136] Initializing watchdogs
[63.591183]   /dev/watchdog0
[63.605329] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[63.609250] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.611249] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.614705] [001/133] (960s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[63.712716] Starting subtest: primary-x-tiled-reflect-x-180
[70.574319] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.871s)
[71.780750] [002/133] (952s left) kms_cursor_crc (cursor-onscreen-32x10)
[71.927863] Starting subtest: cursor-onscreen-32x10
[71.977516] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[72.205655] [003/133] (951s left) kms_pm_dc (dc5-dpms)
[73.282893] Starting subtest: dc5-dpms
[75.361520] Subtest dc5-dpms: SUCCESS (2.079s)
[75.437141] [004/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[75.517872] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[75.522260] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[75.611528] [005/133] (948s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[75.689010] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[76.075515] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[78.809697] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.733s)
[78.820540] Starting dynamic subtest: pipe-A-eDP-1-4
[80.982360] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[80.993865] Starting dynamic subtest: pipe-A-eDP-1-4
[82.994171] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[83.004321] Starting dynamic subtest: pipe-A-eDP-1-x
[85.172757] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[85.545686] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[88.335236] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[88.343693] Starting dynamic subtest: pipe-B-eDP-1-4
[90.510066] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.175s)
[90.517502] Starting dynamic subtest: pipe-B-eDP-1-4
[92.520213] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[92.530184] Starting dynamic subtest: pipe-B-eDP-1-x
[94.710349] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[95.078302] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[97.865227] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[97.876088] Starting dynamic subtest: pipe-C-eDP-1-4
[100.039822] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[100.050179] Starting dynamic subtest: pipe-C-eDP-1-4
[102.050348] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[102.060198] Starting dynamic subtest: pipe-C-eDP-1-x
[104.217640] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s)
[104.579755] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[107.395445] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.822s)
[107.405957] Starting dynamic subtest: pipe-D-eDP-1-4
[109.559038] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[109.569114] Starting dynamic subtest: pipe-D-eDP-1-4
[111.569255] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[111.579664] Starting dynamic subtest: pipe-D-eDP-1-x
[113.747880] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[113.750510] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.060s)
[114.975786] [006/133] (909s left) gem_busy (parallel)
[115.161918] Starting subtest: parallel
[115.164221] Starting dynamic subtest: rcs0
[116.826453] Dynamic subtest rcs0: SUCCESS (1.663s)
[116.837244] Starting dynamic subtest: bcs0
[118.874870] Dynamic subtest bcs0: SUCCESS (2.047s)
[118.885366] Starting dynamic subtest: vcs0
[120.858083] Dynamic subtest vcs0: SUCCESS (1.982s)
[120.868541] Starting dynamic subtest: vcs1
[122.843214] Dynamic subtest vcs1: SUCCESS (1.984s)
[122.854397] Starting dynamic subtest: vecs0
[124.827218] Dynamic subtest vecs0: SUCCESS (1.983s)
[124.838698] Starting dynamic subtest: ccs0
[126.811382] Dynamic subtest ccs0: SUCCESS (1.983s)
[126.814113] Subtest parallel: SUCCESS (11.649s)
[127.046763] [007/133] (897s left) syncobj_wait (wait-all-for-submit-snapshot)
[127.095960] Starting subtest: wait-all-for-submit-snapshot
[127.177225] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[127.253968] [008/133] (897s left) i915_drm_fdinfo (virtual-busy-idle-all)
[127.295991] Starting subtest: virtual-busy-idle-all
[127.300516] Subtest virtual-busy-idle-all: SKIP (0.000s)
[127.358155] [009/133] (897s left) kms_psr (pr-sprite-plane-onoff)
[127.439076] Starting subtest: pr-sprite-plane-onoff
[127.443614] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[127.511782] [010/133] (896s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[127.591681] Starting subtest: fbcpsr-tiling-y
[127.595961] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[127.680203] [011/133] (896s left) gem_spin_batch (spin-all-new)
[127.757350] Starting subtest: spin-all-new
[127.773069] Subtest spin-all-new: SUCCESS (0.015s)
[128.891724] [012/133] (895s left) gem_readwrite (write-bad-handle)
[128.946684] Subtest write-bad-handle: SKIP (0.000s)
[129.012773] [013/133] (895s left) kms_flip (dpms-vs-vblank-race)
[129.080545] Starting subtest: dpms-vs-vblank-race
[129.082839] Starting dynamic subtest: A-eDP1
[132.960844] Dynamic subtest A-eDP1: SUCCESS (3.880s)
[132.970669] Starting dynamic subtest: B-eDP1
[137.563578] Dynamic subtest B-eDP1: SUCCESS (4.602s)
[137.571571] Starting dynamic subtest: C-eDP1
[142.190825] Dynamic subtest C-eDP1: SUCCESS (4.625s)
[142.199869] Starting dynamic subtest: D-eDP1
[146.825395] Dynamic subtest D-eDP1: SUCCESS (4.634s)
[146.827845] Subtest dpms-vs-vblank-race: SUCCESS (17.750s)
[147.706312] [014/133] (876s left) kms_psr (psr-cursor-mmap-cpu)
[147.790965] Starting subtest: psr-cursor-mmap-cpu
[147.793284] Starting dynamic subtest: eDP-1
[149.521954] Dynamic subtest eDP-1: SUCCESS (1.731s)
[149.524269] Subtest psr-cursor-mmap-cpu: SUCCESS (1.731s)
[150.363046] [015/133] (874s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[150.737163] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[151.579014] [016/133] (873s left) gem_ctx_engines (none)
[151.644985] Starting subtest: none
[151.647246] Subtest none: SUCCESS (0.001s)
[151.820589] [017/133] (872s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[151.913335] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[151.917465] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[151.976229] [018/133] (872s left) gem_ctx_param (invalid-set-no-zeromap)
[152.035870] Starting subtest: invalid-set-no-zeromap
[152.038381] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[152.105428] [019/133] (872s left) i915_drm_fdinfo (busy-idle)
[152.148759] Starting subtest: busy-idle
[152.151122] Starting dynamic subtest: rcs0
[152.172771] Dynamic subtest rcs0: SKIP (0.023s)
[152.182441] Starting dynamic subtest: bcs0
[152.186944] Dynamic subtest bcs0: SKIP (0.000s)
[152.194420] Starting dynamic subtest: vcs0
[152.198562] Dynamic subtest vcs0: SKIP (0.000s)
[152.205635] Starting dynamic subtest: vcs1
[152.210065] Dynamic subtest vcs1: SKIP (0.000s)
[152.217057] Starting dynamic subtest: vecs0
[152.221360] Dynamic subtest vecs0: SKIP (0.000s)
[152.228421] Starting dynamic subtest: ccs0
[152.232848] Dynamic subtest ccs0: SKIP (0.000s)
[152.237198] Subtest busy-idle: SKIP (0.026s)
[152.270671] [020/133] (872s left) perf (non-zero-reason)
[152.404720] Starting subtest: non-zero-reason
[152.406597] Starting dynamic subtest: 0-rcs0
[157.727600] Dynamic subtest 0-rcs0: SUCCESS (5.323s)
[157.736810] Starting dynamic subtest: 1-vecs0
[161.609029] Dynamic subtest 1-vecs0: SUCCESS (3.880s)
[161.611996] Subtest non-zero-reason: SUCCESS (9.205s)
[161.655184] [021/133] (863s left) kms_properties (get_properties-sanity-non-atomic)
[161.726107] Starting subtest: get_properties-sanity-non-atomic
[161.728370] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[161.787396] [022/133] (863s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[161.854973] Starting subtest: fbc-psr2-cursor-mmap-gtt
[161.857391] Starting dynamic subtest: eDP-1
[161.861925] Dynamic subtest eDP-1: SKIP (0.000s)
[161.866337] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[161.925979] [023/133] (863s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[162.005299] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[162.007235] Starting dynamic subtest: pipe-A-eDP-1
[164.126854] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.122s)
[164.134979] Starting dynamic subtest: pipe-B-eDP-1
[166.553696] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.426s)
[166.561680] Starting dynamic subtest: pipe-C-eDP-1
[168.673156] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.118s)
[168.685739] Starting dynamic subtest: pipe-D-eDP-1
[170.835080] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.162s)
[170.837050] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.832s)
[172.016521] [024/133] (852s left) kms_prop_blob (invalid-set-prop)
[172.071933] Starting subtest: invalid-set-prop
[172.074148] Subtest invalid-set-prop: SUCCESS (0.000s)
[172.153868] [025/133] (852s left) prime_mmap_coherency (read)
[172.209639] Starting subtest: read
[177.588133] Subtest read: SUCCESS (5.377s)
[177.705479] [026/133] (847s left) kms_properties (crtc-properties-atomic)
[177.779902] Starting subtest: crtc-properties-atomic
[177.782222] Starting dynamic subtest: pipe-A-eDP-1
[178.220547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[178.228384] Starting dynamic subtest: pipe-B-eDP-1
[179.377838] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[179.386560] Starting dynamic subtest: pipe-C-eDP-1
[180.508481] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[180.516466] Starting dynamic subtest: pipe-D-eDP-1
[181.624838] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.113s)
[181.627108] Subtest crtc-properties-atomic: SUCCESS (3.845s)
[182.450130] [027/133] (842s left) kms_color (invalid-ctm-matrix-sizes)
[182.540037] Starting subtest: invalid-ctm-matrix-sizes
[182.542243] Starting dynamic subtest: pipe-A
[182.544100] Dynamic subtest pipe-A: SUCCESS (0.002s)
[182.552320] Starting dynamic subtest: pipe-B
[182.554563] Dynamic subtest pipe-B: SUCCESS (0.003s)
[182.561474] Starting dynamic subtest: pipe-C
[182.563427] Dynamic subtest pipe-C: SUCCESS (0.003s)
[182.570774] Starting dynamic subtest: pipe-D
[182.572999] Dynamic subtest pipe-D: SUCCESS (0.004s)
[182.575199] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[182.619280] [028/133] (842s left) gem_mmap_offset (basic-uaf)
[182.673294] Starting subtest: basic-uaf
[182.675165] Subtest basic-uaf: SUCCESS (0.001s)
[182.774223] [029/133] (842s left) gem_exec_store (dword)
[182.834336] Starting subtest: dword
[182.836578] Starting dynamic subtest: rcs0
[182.891680] Dynamic subtest rcs0: SUCCESS (0.059s)
[182.902318] Starting dynamic subtest: bcs0
[182.936195] Dynamic subtest bcs0: SUCCESS (0.042s)
[182.945771] Starting dynamic subtest: vcs0
[182.978299] Dynamic subtest vcs0: SUCCESS (0.040s)
[182.987627] Starting dynamic subtest: vcs1
[183.020668] Dynamic subtest vcs1: SUCCESS (0.040s)
[183.029880] Starting dynamic subtest: vecs0
[183.061245] Dynamic subtest vecs0: SUCCESS (0.039s)
[183.071045] Starting dynamic subtest: ccs0
[183.105064] Dynamic subtest ccs0: SUCCESS (0.042s)
[183.107716] Subtest dword: SUCCESS (0.274s)
[183.288672] [030/133] (841s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[183.370177] Starting subtest: plane-upscale-20x20-with-pixel-format
[183.372502] Starting dynamic subtest: pipe-A
[184.417602] Dynamic subtest pipe-A: SUCCESS (1.050s)
[184.425297] Starting dynamic subtest: pipe-B
[186.570493] Dynamic subtest pipe-B: SUCCESS (2.151s)
[186.583048] Starting dynamic subtest: pipe-C
[187.745615] Dynamic subtest pipe-C: SUCCESS (1.174s)
[187.754022] Starting dynamic subtest: pipe-D
[188.896364] Dynamic subtest pipe-D: SUCCESS (1.149s)
[188.898718] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.529s)
[190.083826] [031/133] (835s left) api_intel_bb (add-remove-objects)
[190.158078] Starting subtest: add-remove-objects
[190.163914] Subtest add-remove-objects: SUCCESS (0.007s)
[190.276785] [032/133] (834s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[190.353822] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[190.356183] Starting dynamic subtest: pipe-A-eDP-1
[190.376023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[190.385786] Starting dynamic subtest: pipe-B-eDP-1
[190.405354] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[190.413348] Starting dynamic subtest: pipe-C-eDP-1
[190.432299] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[190.440053] Starting dynamic subtest: pipe-D-eDP-1
[190.459369] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[190.461576] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[192.729118] [033/133] (832s left) kms_invalid_mode (bad-vtotal)
[192.803188] Starting subtest: bad-vtotal
[192.805368] Starting dynamic subtest: pipe-A-eDP-1
[193.088333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[193.096779] Starting dynamic subtest: pipe-B-eDP-1
[193.098962] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[193.106688] Starting dynamic subtest: pipe-C-eDP-1
[193.108799] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[193.116308] Starting dynamic subtest: pipe-D-eDP-1
[193.118512] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[193.120700] Subtest bad-vtotal: SUCCESS (0.292s)
[193.982495] [034/133] (831s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[195.974807] Starting subtest: gem-execbuf-stress-pc8
[196.013910] Subtest gem-execbuf-stress-pc8: SKIP (0.037s)
[196.335780] [035/133] (829s left) gem_exec_schedule (semaphore-codependency)
[196.406908] Starting subtest: semaphore-codependency
[196.412924] Subtest semaphore-codependency: SUCCESS (0.015s)
[196.759368] [036/133] (828s left) gem_render_linear_blits (basic)
[196.814432] Starting subtest: basic
[196.832037] Subtest basic: SUCCESS (0.021s)
[196.913357] [037/133] (828s left) perf (mi-rpc)
[197.018867] Starting subtest: mi-rpc
[197.023671] Subtest mi-rpc: SKIP (0.000s)
[197.061868] [038/133] (828s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[197.178953] Starting subtest: protected-encrypted-src-copy-not-readible
[197.290497] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[197.432786] [039/133] (828s left) gem_eio (in-flight-contexts-immediate)
[197.661029] Starting subtest: in-flight-contexts-immediate
[210.848625] Subtest in-flight-contexts-immediate: SUCCESS (13.186s)
[211.009166] [040/133] (814s left) i915_power (sanity)
[211.066113] Starting subtest: sanity
[215.124193] Subtest sanity: SUCCESS (4.050s)
[216.930587] [041/133] (808s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[217.019493] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[217.023662] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[217.132588] [042/133] (808s left) prime_busy (hang)
[217.199028] Starting subtest: hang
[217.200909] Starting dynamic subtest: rcs0
[243.393061] Dynamic subtest rcs0: SUCCESS (26.195s)
[243.401260] Starting dynamic subtest: bcs0
[250.536582] Dynamic subtest bcs0: SUCCESS (7.142s)
[250.546785] Starting dynamic subtest: vcs0
[257.515100] Dynamic subtest vcs0: SUCCESS (6.976s)
[257.522867] Starting dynamic subtest: vcs1
[264.490061] Dynamic subtest vcs1: SUCCESS (6.974s)
[264.497688] Starting dynamic subtest: vecs0
[271.532875] Dynamic subtest vecs0: SUCCESS (7.040s)
[271.548783] Starting dynamic subtest: ccs0
[285.388929] Dynamic subtest ccs0: SUCCESS (13.856s)
[285.391568] Subtest hang: SUCCESS (68.190s)
[285.511152] [043/133] (740s left) kms_draw_crc (draw-method-mmap-wc)
[285.584837] Starting subtest: draw-method-mmap-wc
[285.587081] Starting dynamic subtest: xrgb8888-untiled
[285.820132] Dynamic subtest xrgb8888-untiled: SUCCESS (0.236s)
[285.830959] Starting dynamic subtest: rgb565-untiled
[286.064848] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[286.073544] Starting dynamic subtest: xrgb2101010-untiled
[286.275603] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[286.284420] Starting dynamic subtest: xbgr16161616f-untiled
[286.509182] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[286.526170] Starting dynamic subtest: xrgb8888-xtiled
[286.653260] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.142s)
[286.663818] Starting dynamic subtest: rgb565-xtiled
[286.798293] Dynamic subtest rgb565-xtiled: SUCCESS (0.142s)
[286.809330] Starting dynamic subtest: xrgb2101010-xtiled
[286.930792] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[286.938808] Starting dynamic subtest: xbgr16161616f-xtiled
[287.053102] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[287.061045] Starting dynamic subtest: xrgb8888-4tiled
[287.208619] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[287.218864] Starting dynamic subtest: rgb565-4tiled
[287.386676] Dynamic subtest rgb565-4tiled: SUCCESS (0.174s)
[287.398726] Starting dynamic subtest: xrgb2101010-4tiled
[287.542097] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.153s)
[287.552811] Starting dynamic subtest: xbgr16161616f-4tiled
[287.719739] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.175s)
[287.721725] Subtest draw-method-mmap-wc: SUCCESS (2.137s)
[287.843229] [044/133] (737s left) kms_flip (2x-flip-vs-dpms)
[287.940382] Starting subtest: 2x-flip-vs-dpms
[287.959465] Subtest 2x-flip-vs-dpms: SKIP (0.017s)
[288.040011] [045/133] (737s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[288.111611] Starting subtest: fbc-rgb101010-draw-blt
[292.758063] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.649s)
[293.926790] [046/133] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[294.007592] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[300.815556] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.814s)
[300.963446] [047/133] (724s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[301.046385] Starting subtest: fbc-rgb101010-draw-pwrite
[306.408046] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.365s)
[307.560681] [048/133] (718s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[307.647449] Starting subtest: extended-modeset-hang-oldfb-with-reset
[307.649780] Starting dynamic subtest: pipe-A
[319.348214] Dynamic subtest pipe-A: SUCCESS (11.700s)
[319.357548] Starting dynamic subtest: pipe-D
[331.698189] Dynamic subtest pipe-D: SUCCESS (12.348s)
[331.700504] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.053s)
[332.569742] [049/133] (693s left) api_intel_bb (misplaced-blitter)
[332.638614] Starting subtest: misplaced-blitter
[332.644794] Subtest misplaced-blitter: SUCCESS (0.009s)
[332.761784] [050/133] (693s left) gem_exec_balancer (nop)
[332.834082] Starting subtest: nop
[379.372727] Subtest nop: SUCCESS (46.542s)
[379.665077] [051/133] (646s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[379.748795] Starting subtest: y-tiled-8bpp-rotate-270
[379.753317] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[379.840686] [052/133] (646s left) kms_atomic_transition (plane-all-transition-nonblocking)
[379.919968] Starting subtest: plane-all-transition-nonblocking
[379.922144] Starting dynamic subtest: pipe-A-eDP-1
[382.419995] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[382.740841] Starting dynamic subtest: pipe-B-eDP-1
[386.007325] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.275s)
[386.313513] Subtest plane-all-transition-nonblocking: SUCCESS (6.392s)
[387.132586] [053/133] (638s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[387.192470] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[387.196844] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[387.372534] [054/133] (638s left) gem_render_copy (y-tiled-ccs-to-linear)
[387.425399] Starting subtest: y-tiled-ccs-to-linear
[387.430009] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[387.607193] [055/133] (638s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[387.683408] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[387.687516] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[387.757413] [056/133] (638s left) gem_exec_balancer (sliced)
[387.824743] Starting subtest: sliced
[387.829290] Subtest sliced: SKIP (0.000s)
[388.105117] [057/133] (638s left) gem_eio (create-ext)
[388.328169] Starting subtest: create-ext
[388.633051] Subtest create-ext: SUCCESS (0.307s)
[388.757193] [058/133] (637s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[388.839955] Starting subtest: psr2-plane-move-sf-dmg-area
[388.842154] Starting dynamic subtest: pipe-A-eDP-1
[393.373982] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.534s)
[393.383793] Starting dynamic subtest: pipe-B-eDP-1
[398.684711] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.311s)
[398.687093] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.848s)
[399.561873] [059/133] (626s left) gen9_exec_parse (batch-zero-length)
[399.617200] Subtest batch-zero-length: SKIP (0.000s)
[399.687956] [060/133] (626s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[399.769057] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[403.887338] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.122s)
[405.062020] [061/133] (621s left) gem_exec_params (batch-first)
[405.122061] Starting subtest: batch-first
[405.129674] Subtest batch-first: SUCCESS (0.008s)
[405.244474] [062/133] (621s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[405.307106] Starting subtest: multi-wait-for-submit-submitted-signaled
[405.309435] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[405.417495] [063/133] (621s left) kms_plane_scaling (invalid-parameters)
[405.495047] Starting subtest: invalid-parameters
[405.497313] Starting dynamic subtest: less-than-1-height-src
[405.507422] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[405.516883] Starting dynamic subtest: less-than-1-width-src
[405.522196] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[405.524588] Subtest invalid-parameters: SUCCESS (0.028s)
[405.608414] [064/133] (620s left) gem_exec_params (no-vebox)
[405.665731] Starting subtest: no-vebox
[405.670799] Subtest no-vebox: SUCCESS (0.003s)
[406.941432] [065/133] (619s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[407.010335] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[407.012678] Starting dynamic subtest: pipe-A-eDP-1
[407.035760] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[407.045745] Starting dynamic subtest: pipe-B-eDP-1
[407.066790] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[407.075504] Starting dynamic subtest: pipe-C-eDP-1
[407.097120] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[407.105383] Starting dynamic subtest: pipe-D-eDP-1
[407.127310] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[407.131343] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[409.230088] [066/133] (617s left) syncobj_timeline (wait-all-for-submit-complex)
[409.290464] Starting subtest: wait-all-for-submit-complex
[409.503732] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[409.596323] [067/133] (617s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[409.666060] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[409.692906] Starting dynamic subtest: pipe-A-plane-0
[409.981382] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[409.991089] Starting dynamic subtest: pipe-A-plane-3
[410.214746] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[410.224226] Starting dynamic subtest: pipe-A-plane-5
[410.228185] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[411.315652] Starting dynamic subtest: pipe-B-plane-0
[411.608185] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[411.616932] Starting dynamic subtest: pipe-B-plane-3
[411.852933] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[411.861410] Starting dynamic subtest: pipe-B-plane-5
[411.866199] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[412.168759] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.503s)
[413.011876] [068/133] (613s left) gem_userptr_blits (set-cache-level)
[413.085817] Starting subtest: set-cache-level
[413.090096] Subtest set-cache-level: SKIP (0.000s)
[413.222354] [069/133] (613s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[413.307601] Starting subtest: psr-rgb101010-draw-blt
[420.593988] Subtest psr-rgb101010-draw-blt: SUCCESS (7.289s)
[420.708409] [070/133] (606s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[420.816950] Starting subtest: cursorB-vs-flipA-varying-size
[420.821577] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[420.958522] [071/133] (605s left) kms_sequence (get-forked)
[421.021139] Starting subtest: get-forked
[421.023507] Starting dynamic subtest: pipe-A-eDP-1
[422.900048] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[422.908904] Starting dynamic subtest: pipe-B-eDP-1
[425.455949] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.556s)
[425.465524] Starting dynamic subtest: pipe-C-eDP-1
[427.964284] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.506s)
[427.973513] Starting dynamic subtest: pipe-D-eDP-1
[430.488773] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.522s)
[430.490685] Subtest get-forked: SUCCESS (9.467s)
[431.353673] [072/133] (595s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[432.973408] Starting subtest: modeset-lpsp-stress-no-wait
[442.851742] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.880s)
[442.929861] [073/133] (583s left) drm_read (empty-nonblock)
[443.050422] Starting subtest: empty-nonblock
[443.052881] Subtest empty-nonblock: SUCCESS (0.000s)
[443.163508] [074/133] (583s left) syncobj_timeline (invalid-signal-bad-pad)
[443.220139] Starting subtest: invalid-signal-bad-pad
[443.222217] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[443.333348] [075/133] (583s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[443.418950] Starting subtest: fb-8bpc-vs-panel-8bpc
[443.421219] Starting dynamic subtest: pipe-A-eDP-1
[444.789440] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.371s)
[444.791743] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.372s)
[445.584807] [076/133] (581s left) gem_exec_schedule (lateslice)
[445.648811] Starting subtest: lateslice
[445.651067] Starting dynamic subtest: rcs0
[445.667594] Dynamic subtest rcs0: SUCCESS (0.023s)
[445.679227] Starting dynamic subtest: bcs0
[445.685531] Dynamic subtest bcs0: SUCCESS (0.018s)
[445.694140] Starting dynamic subtest: vcs0
[445.703807] Dynamic subtest vcs0: SUCCESS (0.018s)
[445.712135] Starting dynamic subtest: vcs1
[445.723361] Dynamic subtest vcs1: SUCCESS (0.019s)
[445.731879] Starting dynamic subtest: vecs0
[445.745852] Dynamic subtest vecs0: SUCCESS (0.021s)
[445.754148] Starting dynamic subtest: ccs0
[445.765327] Dynamic subtest ccs0: SUCCESS (0.019s)
[445.767651] Subtest lateslice: SUCCESS (0.122s)
[446.958396] [077/133] (580s left) gem_userptr_blits (process-exit-busy)
[447.023018] Starting subtest: process-exit-busy
[447.034126] Subtest process-exit-busy: SUCCESS (0.012s)
[447.147345] [078/133] (579s left) kms_frontbuffer_tracking (basic)
[447.222226] Starting subtest: basic
[450.398575] Subtest basic: SUCCESS (3.180s)
[450.526811] [079/133] (576s left) gem_exec_reloc (basic-gtt-read)
[450.594208] Subtest basic-gtt-read: SKIP (0.000s)
[450.661023] [080/133] (576s left) kms_lease (master-vs-lease)
[450.738542] Starting subtest: master-vs-lease
[450.740503] Subtest master-vs-lease: SUCCESS (0.002s)
[450.843311] [081/133] (576s left) gem_partial_pwrite_pread (reads-snoop)
[450.901952] Subtest reads-snoop: SKIP (0.000s)
[450.970425] [082/133] (576s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[451.060238] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[451.063977] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[451.155108] [083/133] (576s left) kms_chamelium_audio (hdmi-audio)
[451.508059] Subtest hdmi-audio: SKIP (0.000s)
[452.286969] [084/133] (575s left) gem_mmap_gtt (medium-copy-xy)
[452.339174] Subtest medium-copy-XY: SKIP (0.000s)
[452.396452] [085/133] (574s left) gem_tiled_fence_blits (basic)
[452.458196] Subtest basic: SKIP (0.000s)
[452.526574] [086/133] (574s left) kms_flip (flip-vs-suspend-interruptible)
[452.596705] Starting subtest: flip-vs-suspend-interruptible
[452.599023] Starting dynamic subtest: A-eDP1
[486.114232] Dynamic subtest A-eDP1: SUCCESS (4.335s)
[486.125997] Starting dynamic subtest: B-eDP1
[535.113264] Dynamic subtest B-eDP1: SUCCESS (4.554s)
[535.125734] Starting dynamic subtest: C-eDP1
[584.118910] Dynamic subtest C-eDP1: SUCCESS (4.589s)
[584.129336] Starting dynamic subtest: D-eDP1
[633.093492] Dynamic subtest D-eDP1: SUCCESS (4.589s)
[633.096561] Subtest flip-vs-suspend-interruptible: SUCCESS (18.077s)
[634.291626] [087/133] (393s left) perf (whitelisted-registers-userspace-config)
[634.406967] Starting subtest: whitelisted-registers-userspace-config
[634.409723] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[634.455955] [088/133] (392s left) kms_plane_multiple (2x-tiling-none)
[634.526763] Starting subtest: 2x-tiling-none
[634.531634] Subtest 2x-tiling-none: SKIP (0.000s)
[634.596225] [089/133] (392s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[634.674576] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[635.507694] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.848s)
[635.653581] [090/133] (391s left) kms_async_flips (test-time-stamp-atomic)
[635.726484] Starting subtest: test-time-stamp-atomic
[636.094728] Starting dynamic subtest: pipe-A-eDP-1
[636.856069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.768s)
[637.233729] Starting dynamic subtest: pipe-B-eDP-1
[637.978884] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[638.367205] Starting dynamic subtest: pipe-C-eDP-1
[639.128644] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.775s)
[639.505611] Starting dynamic subtest: pipe-D-eDP-1
[640.259378] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[640.262192] Subtest test-time-stamp-atomic: SUCCESS (4.583s)
[641.405768] [091/133] (386s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[641.478954] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[641.481359] Starting dynamic subtest: pipe-A-default-mode
[644.240535] Dynamic subtest pipe-A-default-mode: SUCCESS (2.775s)
[644.243283] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.777s)
[645.091246] [092/133] (382s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[645.164280] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[651.926565] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.788s)
[652.062913] [093/133] (375s left) gem_exec_fence (submit)
[652.240291] Starting subtest: submit
[652.245597] Subtest submit: SKIP (0.000s)
[654.552893] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[654.557757] [094/133] (373s left) kms_cursor_crc (cursor-suspend)
[654.680495] Starting subtest: cursor-suspend
[654.682857] Starting dynamic subtest: pipe-A-eDP-1
[687.594335] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.237s)
[687.606015] Starting dynamic subtest: pipe-D-eDP-1
[721.603346] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.803s)
[721.606174] Subtest cursor-suspend: SUCCESS (7.042s)
[722.403302] [095/133] (305s left) kms_vblank (wait-forked)
[722.475558] Starting subtest: wait-forked
[722.477842] Starting dynamic subtest: pipe-A-eDP-1
[724.258468] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[724.273128] Starting dynamic subtest: pipe-D-eDP-1
[726.755074] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[726.757449] Subtest wait-forked: SUCCESS (4.337s)
[727.617362] [096/133] (300s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[727.714404] Starting subtest: flip-vs-cursor-busy-crc-legacy
[728.529334] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.822s)
[729.316416] [097/133] (298s left) core_setmaster (master-drop-set-shared-fd)
[729.409566] Starting subtest: master-drop-set-shared-fd
[729.431021] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[729.471345] [098/133] (298s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[729.551342] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[730.227598] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.682s)
[730.412891] [099/133] (297s left) syncobj_wait (invalid-signal-bad-pad)
[730.469592] Starting subtest: invalid-signal-bad-pad
[730.472504] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[730.567944] [100/133] (297s left) perf_pmu (most-busy-check-all)
[730.612698] Starting subtest: most-busy-check-all
[730.615397] Starting dynamic subtest: rcs0
[732.419245] Dynamic subtest rcs0: SUCCESS (1.814s)
[732.431225] Starting dynamic subtest: bcs0
[734.403949] Dynamic subtest bcs0: SUCCESS (1.990s)
[734.417093] Starting dynamic subtest: vcs0
[736.387350] Dynamic subtest vcs0: SUCCESS (1.987s)
[736.400072] Starting dynamic subtest: vcs1
[738.435447] Dynamic subtest vcs1: SUCCESS (2.050s)
[738.448761] Starting dynamic subtest: vecs0
[740.419905] Dynamic subtest vecs0: SUCCESS (1.986s)
[740.433206] Starting dynamic subtest: ccs0
[742.403380] Dynamic subtest ccs0: SUCCESS (1.985s)
[742.406054] Subtest most-busy-check-all: SUCCESS (11.829s)
[742.506493] [101/133] (285s left) syncobj_basic (bad-handle-to-fd)
[742.574235] Starting subtest: bad-handle-to-fd
[742.576573] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[742.667994] [102/133] (285s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[742.746053] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[742.750861] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[743.900371] [103/133] (284s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[743.989473] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[743.994653] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[744.089553] [104/133] (284s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[744.168664] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[744.173926] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[744.258641] [105/133] (283s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[744.400403] Starting subtest: cursor-rapid-movement-32x10
[744.447297] Subtest cursor-rapid-movement-32x10: SKIP (0.039s)
[744.708801] [106/133] (283s left) kms_flip (nonexisting-fb)
[744.780261] Starting subtest: nonexisting-fb
[744.782592] Starting dynamic subtest: A-eDP1
[745.983206] Dynamic subtest A-eDP1: SUCCESS (1.206s)
[745.994404] Starting dynamic subtest: B-eDP1
[747.120083] Dynamic subtest B-eDP1: SUCCESS (1.137s)
[747.132395] Starting dynamic subtest: C-eDP1
[748.245884] Dynamic subtest C-eDP1: SUCCESS (1.126s)
[748.256639] Starting dynamic subtest: D-eDP1
[749.377067] Dynamic subtest D-eDP1: SUCCESS (1.130s)
[749.379837] Subtest nonexisting-fb: SUCCESS (4.606s)
[750.545192] [107/133] (277s left) gem_flink_basic (bad-flink)
[750.609749] Starting subtest: bad-flink
[750.612345] Subtest bad-flink: SUCCESS (0.000s)
[750.715982] [108/133] (277s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[750.782072] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[750.879193] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[750.967955] [109/133] (277s left) gem_lmem_swapping (verify-random-ccs)
[751.011111] Subtest verify-random-ccs: SKIP (0.000s)
[751.058156] [110/133] (277s left) gem_mmap_wc (write)
[751.119478] Subtest write: SKIP (0.000s)
[751.178454] [111/133] (277s left) kms_getfb (getfb2-accept-nv12)
[751.250212] Starting subtest: getfb2-accept-nv12
[751.252828] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[751.350680] [112/133] (277s left) kms_flip (blocking-absolute-wf_vblank)
[751.419353] Starting subtest: blocking-absolute-wf_vblank
[751.422072] Starting dynamic subtest: A-eDP1
[760.201089] Dynamic subtest A-eDP1: SUCCESS (8.778s)
[760.211182] Starting dynamic subtest: B-eDP1
[768.934130] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[768.955980] Starting dynamic subtest: C-eDP1
[777.656450] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[777.667151] Starting dynamic subtest: D-eDP1
[786.381887] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[786.387164] Subtest blocking-absolute-wf_vblank: SUCCESS (34.964s)
[787.590425] [113/133] (240s left) kms_psr (psr-dpms)
[787.670615] Starting subtest: psr-dpms
[787.673077] Starting dynamic subtest: eDP-1
[790.635927] Dynamic subtest eDP-1: SUCCESS (2.963s)
[790.638467] Subtest psr-dpms: SUCCESS (2.964s)
[791.485410] [114/133] (237s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[791.852885] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[792.702861] [115/133] (235s left) sysfs_timeslice_duration (duration)
[792.764514] Starting subtest: duration
[792.767418] Starting dynamic subtest: vecs0
[806.304732] Dynamic subtest vecs0: SUCCESS (13.541s)
[806.318147] Starting dynamic subtest: ccs0
[819.455432] Dynamic subtest ccs0: SUCCESS (13.151s)
[819.469070] Starting dynamic subtest: vcs0
[833.312817] Dynamic subtest vcs0: SUCCESS (13.849s)
[833.333429] Starting dynamic subtest: bcs0
[846.462004] Dynamic subtest bcs0: SUCCESS (13.146s)
[846.475724] Starting dynamic subtest: rcs0
[859.627065] Dynamic subtest rcs0: SUCCESS (13.163s)
[859.640861] Starting dynamic subtest: vcs1
[873.378338] Dynamic subtest vcs1: SUCCESS (13.748s)
[873.381401] Subtest duration: SUCCESS (80.614s)
[873.459242] [116/133] (155s left) gem_exec_fence (syncobj-wait)
[873.930944] Starting subtest: syncobj-wait
[875.435059] Subtest syncobj-wait: SUCCESS (1.506s)
[877.486832] [117/133] (151s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[877.584739] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[877.590041] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[877.685897] [118/133] (151s left) kms_big_fb (linear-64bpp-rotate-0)
[877.766403] Starting subtest: linear-64bpp-rotate-0
[879.323474] Subtest linear-64bpp-rotate-0: SUCCESS (1.556s)
[879.502947] [119/133] (149s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[879.579396] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[884.101941] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.527s)
[885.297928] [120/133] (143s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[885.394230] Starting subtest: fbcpsr-shrfb-scaledprimary
[891.214865] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.826s)
[891.338131] [121/133] (137s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[891.403016] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[891.511979] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[891.591260] [122/133] (137s left) kms_flip (2x-plain-flip-ts-check)
[891.675115] Starting subtest: 2x-plain-flip-ts-check
[891.683008] Subtest 2x-plain-flip-ts-check: SKIP (0.008s)
[891.765232] [123/133] (137s left) gem_exec_flush (basic-uc-prw-default)
[891.819602] Starting subtest: basic-uc-prw-default
[897.302592] Subtest basic-uc-prw-default: SUCCESS (5.484s)
[897.490169] [124/133] (131s left) gem_ctx_persistence (process)
[897.548142] Starting subtest: process
[897.729838] Subtest process: SUCCESS (0.185s)
[897.823415] [125/133] (131s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[897.917873] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[897.922562] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[898.017585] [126/133] (131s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[898.099371] Starting subtest: stress-xrgb8888-yftiled
[898.103534] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[898.176235] [127/133] (130s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[898.259598] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[904.792563] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.537s)
[904.909564] [128/133] (124s left) gem_gpgpu_fill (offset-16x16)
[904.970422] Starting subtest: offset-16x16
[904.977314] Subtest offset-16x16: SUCCESS (0.010s)
[905.108937] [129/133] (124s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[905.208967] Starting subtest: flip-vs-cursor-varying-size
[913.778306] Subtest flip-vs-cursor-varying-size: SUCCESS (8.573s)
[914.577509] [130/133] (114s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[914.666785] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[914.671521] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[914.765857] [131/133] (114s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[914.892746] Starting subtest: dp-mst-lic-type-0-hdcp14
[914.898631] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[915.005527] [132/133] (114s left) gem_pxp (display-protected-crc)
[915.109448] Starting subtest: display-protected-crc
[916.680584] Subtest display-protected-crc: SUCCESS (1.571s)
[917.019507] [133/133] (112s left) kms_psr (fbc-psr-cursor-blt)
[917.148458] Starting subtest: fbc-psr-cursor-blt
[917.151211] Starting dynamic subtest: eDP-1
[917.156240] Dynamic subtest eDP-1: SKIP (0.000s)
[917.161257] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[917.292172] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_pm_dc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_async_flips
results: parsing output: 5/ for test: gem_busy
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_spin_batch
results: parsing output: 11/ for test: gem_readwrite
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_chamelium_edid
results: parsing output: 15/ for test: gem_ctx_engines
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_properties
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_prop_blob
results: parsing output: 24/ for test: prime_mmap_coherency
results: parsing output: 25/ for test: kms_properties
results: parsing output: 26/ for test: kms_color
results: parsing output: 27/ for test: gem_mmap_offset
results: parsing output: 28/ for test: gem_exec_store
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: api_intel_bb
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_invalid_mode
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_render_linear_blits
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: i915_power
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: prime_busy
results: parsing output: 42/ for test: kms_draw_crc
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_busy
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_atomic_transition
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: gem_eio
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: gen9_exec_parse
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_plane
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_sequence
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: drm_read
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_dither
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_chamelium_audio
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: gem_tiled_fence_blits
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: kms_plane_multiple
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_async_flips
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: core_setmaster
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: gem_flink_basic
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: gem_mmap_wc
results: parsing output: 110/ for test: kms_getfb
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_pipe_stress
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_gpgpu_fill
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_content_protection
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: kms_psr
Done.