[55.840929] Initializing watchdogs
[55.840985]   /dev/watchdog0
[55.855704] [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]
[55.860132] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.862483] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.865786] [001/131] (960s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[55.988766] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[55.991103] Starting dynamic subtest: pipe-A-default-mode
[56.313022] Dynamic subtest pipe-A-default-mode: SKIP (0.323s)
[56.317751] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.324s)
[57.127425] [002/131] (959s left) kms_feature_discovery (psr2)
[57.231876] Starting subtest: psr2
[57.234061] Subtest psr2: SUCCESS (0.000s)
[57.323978] [003/131] (959s left) gem_ctx_shared (q-promotion)
[57.380634] Starting subtest: Q-promotion
[57.383079] Starting dynamic subtest: rcs0
[57.503075] Dynamic subtest rcs0: SUCCESS (0.122s)
[57.517357] Starting dynamic subtest: vcs0
[57.581060] Dynamic subtest vcs0: SUCCESS (0.078s)
[57.594429] Starting dynamic subtest: vcs1
[57.656927] Dynamic subtest vcs1: SUCCESS (0.074s)
[57.670249] Starting dynamic subtest: vecs0
[57.726947] Dynamic subtest vecs0: SUCCESS (0.071s)
[57.741538] Starting dynamic subtest: ccs0
[57.808264] Dynamic subtest ccs0: SUCCESS (0.081s)
[57.810605] Subtest Q-promotion: SUCCESS (0.427s)
[58.991279] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[58.994437] [004/131] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[59.099071] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[59.103700] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[59.192467] [005/131] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[59.294453] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[66.624788] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.333s)
[66.767236] [006/131] (949s left) vgem_basic (dmabuf-export)
[66.812557] Starting subtest: dmabuf-export
[66.838164] Subtest dmabuf-export: SUCCESS (0.027s)
[66.937893] [007/131] (949s left) kms_joiner (basic-force-ultra-joiner)
[67.031621] Starting subtest: basic-force-ultra-joiner
[67.036152] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[67.099572] [008/131] (949s left) gem_ctx_isolation (preservation-reset)
[67.268255] Starting subtest: preservation-reset
[67.271315] Starting dynamic subtest: rcs0
[67.527681] Dynamic subtest rcs0: SUCCESS (0.260s)
[67.537709] Starting dynamic subtest: bcs0
[67.842115] Dynamic subtest bcs0: SUCCESS (0.314s)
[67.852284] Starting dynamic subtest: vcs0
[68.161921] Dynamic subtest vcs0: SUCCESS (0.320s)
[68.169742] Starting dynamic subtest: vcs1
[70.183508] Dynamic subtest vcs1: SUCCESS (2.021s)
[70.194041] Starting dynamic subtest: vecs0
[72.312564] Dynamic subtest vecs0: SUCCESS (2.129s)
[72.321955] Starting dynamic subtest: ccs0
[74.200600] Dynamic subtest ccs0: SUCCESS (1.888s)
[74.203138] Subtest preservation-reset: SUCCESS (6.935s)
[74.340395] [009/131] (942s left) i915_query (query-regions-garbage-items)
[74.392242] Starting subtest: query-regions-garbage-items
[74.394726] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[74.502983] [010/131] (942s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[74.600228] Starting subtest: psr-rgb565-draw-pwrite
[81.495934] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.900s)
[81.621305] [011/131] (935s left) perf_pmu (busy-idle-no-semaphores)
[81.663837] Starting subtest: busy-idle-no-semaphores
[81.666131] Starting dynamic subtest: rcs0
[82.346055] Dynamic subtest rcs0: SUCCESS (0.681s)
[82.357315] Starting dynamic subtest: bcs0
[82.995497] Dynamic subtest bcs0: SUCCESS (0.649s)
[83.005427] Starting dynamic subtest: vcs0
[83.645827] Dynamic subtest vcs0: SUCCESS (0.650s)
[83.656926] Starting dynamic subtest: vcs1
[85.503455] Dynamic subtest vcs1: SUCCESS (1.856s)
[85.517414] Starting dynamic subtest: vecs0
[87.552057] Dynamic subtest vecs0: SUCCESS (2.048s)
[87.562904] Starting dynamic subtest: ccs0
[89.534560] Dynamic subtest ccs0: SUCCESS (1.982s)
[89.537220] Subtest busy-idle-no-semaphores: SUCCESS (7.869s)
[89.651429] [012/131] (927s left) kms_flip (basic-flip-vs-dpms)
[89.769462] Starting subtest: basic-flip-vs-dpms
[89.771948] Starting dynamic subtest: A-eDP1
[92.382226] Dynamic subtest A-eDP1: SUCCESS (2.612s)
[92.392240] Starting dynamic subtest: B-eDP1
[94.551588] Dynamic subtest B-eDP1: SUCCESS (2.167s)
[94.559850] Starting dynamic subtest: C-eDP1
[96.624693] Dynamic subtest C-eDP1: SUCCESS (2.073s)
[96.633507] Starting dynamic subtest: D-eDP1
[98.709812] Dynamic subtest D-eDP1: SUCCESS (2.084s)
[98.711888] Subtest basic-flip-vs-dpms: SUCCESS (8.943s)
[99.508853] [013/131] (917s left) gem_exec_balancer (hang)
[99.765336] Starting subtest: hang
[101.391696] Subtest hang: SUCCESS (1.628s)
[101.511537] [014/131] (915s left) gem_mmap_gtt (zero-extend)
[101.570202] Subtest zero-extend: SKIP (0.000s)
[101.627379] [015/131] (915s left) gem_lmem_swapping (parallel-random)
[101.666513] Subtest parallel-random: SKIP (0.000s)
[101.705222] [016/131] (915s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[101.828166] Starting subtest: short-flip-before-cursor-toggle
[102.742846] Subtest short-flip-before-cursor-toggle: SUCCESS (0.913s)
[103.543209] [017/131] (913s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[103.595768] Starting subtest: multi-wait-all-for-submit-signaled
[103.598080] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[103.693117] [018/131] (913s left) kms_flip (flip-vs-absolute-wf_vblank)
[103.791247] Starting subtest: flip-vs-absolute-wf_vblank
[103.793606] Starting dynamic subtest: A-eDP1
[112.692122] Dynamic subtest A-eDP1: SUCCESS (8.899s)
[112.702458] Starting dynamic subtest: B-eDP1
[121.630097] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[121.640551] Starting dynamic subtest: C-eDP1
[130.603481] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[130.612760] Starting dynamic subtest: D-eDP1
[139.536712] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[139.539243] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.700s)
[140.711100] [019/131] (876s left) gem_ppgtt (flink-and-close-vma-leak)
[140.771750] Starting subtest: flink-and-close-vma-leak
[140.811852] Subtest flink-and-close-vma-leak: SUCCESS (0.040s)
[140.944763] [020/131] (876s left) gem_exec_fence (basic-wait-all)
[141.000842] Starting subtest: basic-wait-all
[141.094663] Subtest basic-wait-all: SUCCESS (0.095s)
[143.009739] [021/131] (874s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[143.117959] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[143.129273] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[143.222839] [022/131] (873s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[143.323707] Starting subtest: y-tiled-64bpp-rotate-0
[143.327977] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[143.437988] [023/131] (873s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[143.536668] Starting subtest: 4-tiled-8bpp-rotate-180
[144.616952] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.082s)
[144.760761] [024/131] (872s left) kms_chamelium_color (ctm-blue-to-red)
[144.855206] Subtest ctm-blue-to-red: SKIP (0.000s)
[144.899615] [025/131] (872s left) gem_exec_reloc (basic-gtt-cpu)
[144.957740] Subtest basic-gtt-cpu: SKIP (0.000s)
[145.027700] [026/131] (872s left) kms_addfb_basic (master-rmfb)
[145.068255] Starting subtest: master-rmfb
[145.070075] Subtest master-rmfb: SUCCESS (0.001s)
[145.217970] [027/131] (872s left) gem_render_copy_redux (normal)
[145.275897] Starting subtest: normal
[145.565363] Subtest normal: SUCCESS (0.289s)
[145.700662] [028/131] (871s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[150.706984] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[150.711762] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[151.541345] [029/131] (865s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[151.635174] Starting subtest: compare-crc-sanitycheck-xr24
[151.637624] Starting dynamic subtest: pipe-A-eDP-1
[152.249932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[152.257954] Starting dynamic subtest: pipe-B-eDP-1
[153.496476] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s)
[153.507681] Starting dynamic subtest: pipe-C-eDP-1
[154.683651] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.185s)
[154.692978] Starting dynamic subtest: pipe-D-eDP-1
[155.921860] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[155.924219] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.284s)
[156.763847] [030/131] (860s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[156.822540] Starting subtest: single-wait-all-for-submit-available-signaled
[156.824878] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[156.928781] [031/131] (860s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[157.029152] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[157.033575] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[157.140837] [032/131] (860s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[157.527561] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[158.377097] [033/131] (859s left) kms_fence_pin_leak
[158.557770] [034/131] (859s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[158.672264] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[158.676512] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[158.771296] [035/131] (858s left) gem_exec_schedule (implicit-write-read)
[158.840308] Starting subtest: implicit-write-read
[158.842519] Starting dynamic subtest: rcs0
[158.942244] Dynamic subtest rcs0: SUCCESS (0.109s)
[158.951928] Starting dynamic subtest: vcs0
[159.034971] Dynamic subtest vcs0: SUCCESS (0.092s)
[159.045984] Starting dynamic subtest: vcs1
[159.116716] Dynamic subtest vcs1: SUCCESS (0.081s)
[159.127026] Starting dynamic subtest: vecs0
[159.198550] Dynamic subtest vecs0: SUCCESS (0.082s)
[159.206598] Starting dynamic subtest: ccs0
[159.293951] Dynamic subtest ccs0: SUCCESS (0.095s)
[159.296059] Subtest implicit-write-read: SUCCESS (0.462s)
[159.994806] [036/131] (857s left) gem_sync (basic-all)
[160.065624] Starting subtest: basic-all
[162.930284] Subtest basic-all: SUCCESS (2.876s)
[163.111813] [037/131] (854s left) kms_psr (psr2-cursor-plane-move)
[163.216698] Starting subtest: psr2-cursor-plane-move
[163.218985] Starting dynamic subtest: eDP-1
[164.903293] Dynamic subtest eDP-1: SUCCESS (1.687s)
[164.905599] Subtest psr2-cursor-plane-move: SUCCESS (1.687s)
[165.783655] [038/131] (852s left) kms_getfb (getfb-repeated-different-handles)
[165.888955] Starting subtest: getfb-repeated-different-handles
[165.890879] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[165.987656] [039/131] (851s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[166.046136] Starting subtest: multi-wait-all-for-submit-unsubmitted
[166.153154] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[166.228669] [040/131] (851s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[166.288728] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[166.290977] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[166.399314] [041/131] (851s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[166.501863] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[166.504302] Starting dynamic subtest: pipe-A-default-mode
[167.634641] Dynamic subtest pipe-A-default-mode: SKIP (1.128s)
[167.639107] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.130s)
[167.798164] [042/131] (850s left) gem_spin_batch (spin-each)
[167.850657] Starting subtest: spin-each
[171.117912] Subtest spin-each: SUCCESS (3.257s)
[173.000438] [043/131] (845s left) kms_vblank (wait-forked-hang)
[173.107141] Starting subtest: wait-forked-hang
[173.109403] Starting dynamic subtest: pipe-A-eDP-1
[199.706501] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.597s)
[199.721620] Starting dynamic subtest: pipe-D-eDP-1
[224.653266] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.944s)
[224.655373] Subtest wait-forked-hang: SUCCESS (51.545s)
[225.470309] [044/131] (792s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[225.582745] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[225.587278] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[225.686523] [045/131] (792s left) api_intel_bb (intel-bb-blit-none)
[225.745682] Starting subtest: intel-bb-blit-none
[229.792646] Subtest intel-bb-blit-none: SUCCESS (4.048s)
[229.917169] [046/131] (788s left) gem_exec_params (no-blt)
[229.982177] Starting subtest: no-blt
[229.987432] Subtest no-blt: SUCCESS (0.005s)
[230.123266] [047/131] (788s left) prime_busy (hang)
[230.181801] Starting subtest: hang
[230.184223] Starting dynamic subtest: rcs0
[256.437329] Dynamic subtest rcs0: SUCCESS (26.240s)
[256.444936] Starting dynamic subtest: bcs0
[263.584460] Dynamic subtest bcs0: SUCCESS (7.158s)
[263.592160] Starting dynamic subtest: vcs0
[270.561879] Dynamic subtest vcs0: SUCCESS (6.977s)
[270.569390] Starting dynamic subtest: vcs1
[277.545897] Dynamic subtest vcs1: SUCCESS (6.977s)
[277.555642] Starting dynamic subtest: vecs0
[284.586110] Dynamic subtest vecs0: SUCCESS (7.036s)
[284.595905] Starting dynamic subtest: ccs0
[298.416882] Dynamic subtest ccs0: SUCCESS (13.836s)
[298.419453] Subtest hang: SUCCESS (68.228s)
[298.553466] [048/131] (719s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[298.660366] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[298.662759] Starting dynamic subtest: pipe-A
[298.682414] Dynamic subtest pipe-A: SKIP (0.017s)
[298.691596] Starting dynamic subtest: pipe-B
[298.714464] Dynamic subtest pipe-B: SKIP (0.031s)
[298.722869] Starting dynamic subtest: pipe-C
[298.745500] Dynamic subtest pipe-C: SKIP (0.031s)
[298.753461] Starting dynamic subtest: pipe-D
[298.776099] Dynamic subtest pipe-D: SKIP (0.031s)
[298.779885] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.111s)
[298.884737] [049/131] (719s left) gem_tiled_wc
[299.005757] [050/131] (719s left) kms_psr (fbc-pr-sprite-render)
[299.099426] Starting subtest: fbc-pr-sprite-render
[299.103802] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[299.174862] [051/131] (719s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[299.242993] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[299.247479] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[299.427735] [052/131] (718s left) gen9_exec_parse (bb-chained)
[299.486655] Subtest bb-chained: SKIP (0.000s)
[299.573231] [053/131] (718s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[299.624958] Starting subtest: single-wait-for-submit-unsubmitted
[299.729750] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[299.803851] [054/131] (718s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[299.928734] Starting subtest: short-busy-flip-before-cursor-toggle
[299.933232] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[300.072996] [055/131] (718s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[300.182441] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[300.861706] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[301.052128] [056/131] (717s left) gem_exec_whisper (basic-contexts-priority)
[301.113770] Starting subtest: basic-contexts-priority
[324.300778] Subtest basic-contexts-priority: SUCCESS (23.180s)
[324.482330] [057/131] (694s left) gem_softpin (allocator-evict)
[324.554422] Starting subtest: allocator-evict
[324.556583] Starting dynamic subtest: rcs0
[348.829320] Dynamic subtest rcs0: SUCCESS (24.272s)
[348.838847] Starting dynamic subtest: bcs0
[372.313261] Dynamic subtest bcs0: SUCCESS (23.482s)
[372.322076] Starting dynamic subtest: vcs0
[396.209334] Dynamic subtest vcs0: SUCCESS (23.894s)
[396.219514] Starting dynamic subtest: vcs1
[419.745578] Dynamic subtest vcs1: SUCCESS (23.535s)
[419.756400] Starting dynamic subtest: vecs0
[443.602923] Dynamic subtest vecs0: SUCCESS (23.856s)
[443.612639] Starting dynamic subtest: ccs0
[467.409522] Dynamic subtest ccs0: SUCCESS (23.805s)
[467.411692] Subtest allocator-evict: SUCCESS (142.849s)
[467.490647] [058/131] (551s left) kms_psr (fbc-psr-cursor-plane-move)
[467.647449] Starting subtest: fbc-psr-cursor-plane-move
[467.649848] Starting dynamic subtest: eDP-1
[467.654150] Dynamic subtest eDP-1: SKIP (0.000s)
[467.658292] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[467.720804] [059/131] (550s left) gem_create (create-ext-placement-all)
[467.894881] Starting subtest: create-ext-placement-all
[467.898033] Subtest create-ext-placement-all: SUCCESS (0.000s)
[468.003570] [060/131] (550s left) kms_addfb_basic (invalid-get-prop)
[468.063764] Starting subtest: invalid-get-prop
[468.066130] Subtest invalid-get-prop: SUCCESS (0.000s)
[468.217886] [061/131] (550s left) syncobj_timeline (invalid-query-bad-pad)
[468.273498] Starting subtest: invalid-query-bad-pad
[468.275832] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[468.366498] [062/131] (550s left) kms_lease (cursor-implicit-plane)
[468.464094] Starting subtest: cursor-implicit-plane
[468.466432] Starting dynamic subtest: pipe-A-eDP-1
[468.915031] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[468.929861] Starting dynamic subtest: pipe-B-eDP-1
[470.070484] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s)
[470.079157] Starting dynamic subtest: pipe-C-eDP-1
[471.197699] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[471.208542] Starting dynamic subtest: pipe-D-eDP-1
[472.330525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[472.332790] Subtest cursor-implicit-plane: SUCCESS (3.866s)
[473.193855] [063/131] (545s left) sysfs_timeslice_duration (duration)
[473.249164] Starting subtest: duration
[473.251605] Starting dynamic subtest: vecs0
[486.835616] Dynamic subtest vecs0: SUCCESS (13.583s)
[486.847209] Starting dynamic subtest: ccs0
[500.008351] Dynamic subtest ccs0: SUCCESS (13.172s)
[500.019068] Starting dynamic subtest: vcs0
[513.842896] Dynamic subtest vcs0: SUCCESS (13.831s)
[513.854379] Starting dynamic subtest: bcs0
[526.994398] Dynamic subtest bcs0: SUCCESS (13.142s)
[527.012833] Starting dynamic subtest: rcs0
[540.156032] Dynamic subtest rcs0: SUCCESS (13.169s)
[540.167749] Starting dynamic subtest: vcs1
[553.842761] Dynamic subtest vcs1: SUCCESS (13.682s)
[553.845781] Subtest duration: SUCCESS (80.589s)
[553.921649] [064/131] (464s left) gem_exec_schedule (preempt-user)
[553.992255] Starting subtest: preempt-user
[553.994526] Starting dynamic subtest: rcs0
[554.022444] Dynamic subtest rcs0: SUCCESS (0.035s)
[554.031542] Starting dynamic subtest: bcs0
[554.054440] Dynamic subtest bcs0: SUCCESS (0.031s)
[554.064377] Starting dynamic subtest: vcs0
[554.079313] Dynamic subtest vcs0: SUCCESS (0.024s)
[554.092163] Starting dynamic subtest: vcs1
[554.101298] Dynamic subtest vcs1: SUCCESS (0.022s)
[554.110307] Starting dynamic subtest: vecs0
[554.126263] Dynamic subtest vecs0: SUCCESS (0.025s)
[554.135306] Starting dynamic subtest: ccs0
[554.156737] Dynamic subtest ccs0: SUCCESS (0.030s)
[554.159091] Subtest preempt-user: SUCCESS (0.169s)
[556.025223] [065/131] (462s left) kms_flip (dpms-off-confusion-interruptible)
[556.139544] Starting subtest: dpms-off-confusion-interruptible
[556.141773] Starting dynamic subtest: A-eDP1
[564.824717] Dynamic subtest A-eDP1: SUCCESS (8.649s)
[564.834081] Starting dynamic subtest: B-eDP1
[573.451381] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[573.464259] Starting dynamic subtest: C-eDP1
[582.079211] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[582.089190] Starting dynamic subtest: D-eDP1
[590.709058] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[590.711378] Subtest dpms-off-confusion-interruptible: SUCCESS (34.525s)
[591.844093] [066/131] (427s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[591.950830] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[591.953243] Starting dynamic subtest: pipe-A
[592.079566] Dynamic subtest pipe-A: SKIP (0.117s)
[592.088311] Starting dynamic subtest: pipe-B
[593.238555] Dynamic subtest pipe-B: SKIP (1.163s)
[593.248295] Starting dynamic subtest: pipe-C
[594.454937] Dynamic subtest pipe-C: SUCCESS (1.223s)
[594.465242] Starting dynamic subtest: pipe-D
[595.685500] Dynamic subtest pipe-D: SUCCESS (1.230s)
[595.687763] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.735s)
[596.884474] [067/131] (422s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[596.990485] Starting subtest: crc-primary-basic-yf-tiled-ccs
[596.992909] Starting dynamic subtest: pipe-A-eDP-1
[597.016318] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[597.028164] Starting dynamic subtest: pipe-B-eDP-1
[597.051064] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[597.061095] Starting dynamic subtest: pipe-C-eDP-1
[597.083286] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[597.092105] Starting dynamic subtest: pipe-D-eDP-1
[597.113696] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[597.118103] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[599.176637] [068/131] (419s left) gem_partial_pwrite_pread (reads-snoop)
[599.238307] Subtest reads-snoop: SKIP (0.000s)
[599.315875] [069/131] (419s left) gen9_exec_parse (allowed-single)
[599.377588] Subtest allowed-single: SKIP (0.000s)
[599.454288] [070/131] (419s left) kms_busy (extended-modeset-hang-newfb)
[599.553073] Starting subtest: extended-modeset-hang-newfb
[599.555422] Starting dynamic subtest: pipe-A
[633.810746] Dynamic subtest pipe-A: SUCCESS (34.254s)
[633.821712] Starting dynamic subtest: pipe-D
[656.769193] Dynamic subtest pipe-D: SUCCESS (22.955s)
[656.771486] Subtest extended-modeset-hang-newfb: SUCCESS (57.213s)
[657.555348] [071/131] (361s left) prime_self_import (basic-llseek-size)
[657.588222] Starting subtest: basic-llseek-size
[657.618617] Subtest basic-llseek-size: SUCCESS (0.031s)
[657.728389] [072/131] (361s left) i915_hangman (engine-engine-error)
[657.799355] Starting subtest: engine-engine-error
[657.801662] Starting dynamic subtest: rcs0
[658.868348] Dynamic subtest rcs0: SUCCESS (1.067s)
[658.878767] Starting dynamic subtest: bcs0
[660.851044] Dynamic subtest bcs0: SUCCESS (1.980s)
[660.863858] Starting dynamic subtest: vcs0
[662.899490] Dynamic subtest vcs0: SUCCESS (2.046s)
[662.913806] Starting dynamic subtest: vcs1
[664.883418] Dynamic subtest vcs1: SUCCESS (1.981s)
[664.893715] Starting dynamic subtest: vecs0
[666.867421] Dynamic subtest vecs0: SUCCESS (1.982s)
[666.879254] Starting dynamic subtest: ccs0
[668.850560] Dynamic subtest ccs0: SUCCESS (1.981s)
[668.853502] Subtest engine-engine-error: SUCCESS (11.050s)
[668.933696] [073/131] (350s left) kms_psr (psr-primary-mmap-gtt)
[669.035519] Starting subtest: psr-primary-mmap-gtt
[669.037926] Starting dynamic subtest: eDP-1
[670.450486] Dynamic subtest eDP-1: SKIP (1.409s)
[670.455381] Subtest psr-primary-mmap-gtt: SKIP (1.410s)
[670.636321] [074/131] (348s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[670.736341] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[670.738713] Starting dynamic subtest: A-eDP1
[674.321353] Dynamic subtest A-eDP1: SUCCESS (3.583s)
[674.331241] Starting dynamic subtest: B-eDP1
[677.542578] Dynamic subtest B-eDP1: SUCCESS (3.216s)
[677.553175] Starting dynamic subtest: C-eDP1
[680.632148] Dynamic subtest C-eDP1: SUCCESS (3.091s)
[680.641471] Starting dynamic subtest: D-eDP1
[683.730840] Dynamic subtest D-eDP1: SUCCESS (3.098s)
[683.733269] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.997s)
[684.534930] [075/131] (334s left) gem_userptr_blits (unsync-unmap-after-close)
[684.601466] Subtest unsync-unmap-after-close: SKIP (0.000s)
[684.719503] [076/131] (334s left) kms_async_flips (invalid-async-flip)
[684.812144] Starting subtest: invalid-async-flip
[685.186110] Starting dynamic subtest: pipe-A-eDP-1
[685.960061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.775s)
[686.317361] Starting dynamic subtest: pipe-B-eDP-1
[687.097386] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[687.455718] Starting dynamic subtest: pipe-C-eDP-1
[688.212516] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[688.568093] Starting dynamic subtest: pipe-D-eDP-1
[689.350239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.792s)
[689.352581] Subtest invalid-async-flip: SUCCESS (4.541s)
[690.498771] [077/131] (328s left) perf (non-system-wide-paranoid)
[690.635080] Starting subtest: non-system-wide-paranoid
[690.661136] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[690.709764] [078/131] (328s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[690.805091] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[690.809320] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[690.921224] [079/131] (328s left) kms_pm_rpm (cursor)
[693.053594] Starting subtest: cursor
[693.058606] Subtest cursor: SKIP (0.000s)
[693.421365] [080/131] (326s left) gem_gpgpu_fill (offset-16x16)
[693.499946] Starting subtest: offset-16x16
[693.505672] Subtest offset-16x16: SUCCESS (0.006s)
[693.808704] [081/131] (325s left) gem_eio (reset-stress)
[694.069993] Starting subtest: reset-stress
[738.357965] Subtest reset-stress: SUCCESS (44.285s)
[739.961604] [082/131] (279s left) gem_exec_alignment (pi-isolated)
[740.022565] Starting subtest: pi-isolated
[791.314078] Subtest pi-isolated: SUCCESS (51.286s)
[792.236384] [083/131] (227s left) kms_cursor_crc (cursor-sliding-128x128)
[792.522809] Starting subtest: cursor-sliding-128x128
[792.525056] Starting dynamic subtest: pipe-A-eDP-1
[795.782260] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.258s)
[795.809344] Starting dynamic subtest: pipe-D-eDP-1
[799.681778] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.877s)
[799.684243] Subtest cursor-sliding-128x128: SUCCESS (7.160s)
[800.557672] [084/131] (219s left) kms_draw_crc (draw-method-mmap-wc)
[800.669446] Starting subtest: draw-method-mmap-wc
[800.671708] Starting dynamic subtest: xrgb8888-untiled
[800.869049] Dynamic subtest xrgb8888-untiled: SUCCESS (0.202s)
[800.878505] Starting dynamic subtest: rgb565-untiled
[801.057961] Dynamic subtest rgb565-untiled: SUCCESS (0.188s)
[801.067153] Starting dynamic subtest: xrgb2101010-untiled
[801.269276] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[801.278131] Starting dynamic subtest: xbgr16161616f-untiled
[801.470058] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[801.478983] Starting dynamic subtest: xrgb8888-xtiled
[801.590910] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[801.599722] Starting dynamic subtest: rgb565-xtiled
[801.714684] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[801.727614] Starting dynamic subtest: xrgb2101010-xtiled
[801.813059] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.098s)
[801.821701] Starting dynamic subtest: xbgr16161616f-xtiled
[801.924092] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[801.932762] Starting dynamic subtest: xrgb8888-4tiled
[802.079690] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[802.088253] Starting dynamic subtest: rgb565-4tiled
[802.213031] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[802.222831] Starting dynamic subtest: xrgb2101010-4tiled
[802.346717] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[802.357090] Starting dynamic subtest: xbgr16161616f-4tiled
[802.513152] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[802.515141] Subtest draw-method-mmap-wc: SUCCESS (1.847s)
[802.617839] [085/131] (217s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[802.705959] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[802.707741] Starting dynamic subtest: pipe-A-eDP-1
[802.756485] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[802.766486] Starting dynamic subtest: pipe-B-eDP-1
[802.813541] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[802.823527] Starting dynamic subtest: pipe-C-eDP-1
[802.870292] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[802.878732] Starting dynamic subtest: pipe-D-eDP-1
[802.925273] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[802.928800] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[804.934336] [086/131] (214s left) kms_getfb (getfb2-into-addfb2)
[805.026112] Starting subtest: getfb2-into-addfb2
[805.028449] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[805.133072] [087/131] (214s left) gem_ctx_persistence (legacy-engines-cleanup)
[805.193642] Starting subtest: legacy-engines-cleanup
[805.196071] Starting dynamic subtest: render
[805.287815] Dynamic subtest render: SUCCESS (0.093s)
[805.299788] Starting dynamic subtest: bsd1
[805.313486] Dynamic subtest bsd1: SUCCESS (0.024s)
[805.322433] Starting dynamic subtest: bsd2
[805.396684] Dynamic subtest bsd2: SUCCESS (0.081s)
[805.408547] Starting dynamic subtest: blt
[805.448561] Dynamic subtest blt: SUCCESS (0.050s)
[805.458451] Starting dynamic subtest: vebox
[805.478400] Dynamic subtest vebox: SUCCESS (0.028s)
[805.480798] Subtest legacy-engines-cleanup: SUCCESS (0.285s)
[805.643458] [088/131] (214s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[805.756837] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[805.761285] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[805.845511] [089/131] (214s left) api_intel_allocator (reloc-allocator)
[805.904056] Starting subtest: reloc-allocator
[805.906158] Starting dynamic subtest: basic
[805.908282] Dynamic subtest basic: SUCCESS (0.003s)
[805.919928] Starting dynamic subtest: parallel-one
[805.922124] Dynamic subtest parallel-one: SUCCESS (0.009s)
[805.930267] Starting dynamic subtest: print
[805.932209] Dynamic subtest print: SUCCESS (0.000s)
[805.940084] Starting dynamic subtest: reuse
[805.941916] Dynamic subtest reuse: SUCCESS (0.000s)
[805.949792] Starting dynamic subtest: fork-reopen-allocator
[805.951711] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[805.953613] Subtest reloc-allocator: SUCCESS (0.028s)
[806.064998] [090/131] (213s left) kms_cursor_crc (cursor-onscreen-max-size)
[806.379343] Starting subtest: cursor-onscreen-max-size
[806.384738] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[806.521680] [091/131] (213s left) api_intel_bb (reset-bb)
[806.585976] Starting subtest: reset-bb
[806.590474] Subtest reset-bb: SUCCESS (0.004s)
[806.731704] [092/131] (213s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[806.822348] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[814.138311] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.317s)
[814.261600] [093/131] (205s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[814.357253] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[814.359434] Starting dynamic subtest: pipe-A-eDP-1
[814.381494] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[814.390741] Starting dynamic subtest: pipe-B-eDP-1
[814.411912] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[814.420766] Starting dynamic subtest: pipe-C-eDP-1
[814.442876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[814.452484] Starting dynamic subtest: pipe-D-eDP-1
[814.473974] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[814.477837] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[816.525718] [094/131] (203s left) gem_mmap_offset (open-flood)
[816.580049] Starting subtest: open-flood
[838.066980] Subtest open-flood: SUCCESS (21.489s)
[838.195331] [095/131] (181s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[838.303949] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[838.307483] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[838.423430] [096/131] (181s left) kms_prop_blob (blob-prop-lifetime)
[838.469872] Starting subtest: blob-prop-lifetime
[838.471586] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[838.575545] [097/131] (181s left) kms_chamelium_audio (dp-audio-edid)
[838.963347] Subtest dp-audio-edid: SKIP (0.000s)
[839.746746] [098/131] (180s left) kms_content_protection (mei-interface)
[839.903592] Starting subtest: mei-interface
[839.914422] Subtest mei-interface: SKIP (0.008s)
[840.054974] [099/131] (180s left) kms_chamelium_hpd (dp-hpd)
[840.448632] Subtest dp-hpd: SKIP (0.000s)
[841.271047] [100/131] (179s left) syncobj_eventfd (invalid-illegal-eventfd)
[841.336692] Starting subtest: invalid-illegal-eventfd
[841.339073] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[841.455911] [101/131] (178s left) kms_flip (dpms-vs-vblank-race-interruptible)
[841.550745] Starting subtest: dpms-vs-vblank-race-interruptible
[841.553052] Starting dynamic subtest: A-eDP1
[846.480960] Dynamic subtest A-eDP1: SUCCESS (4.927s)
[846.490530] Starting dynamic subtest: B-eDP1
[851.102200] Dynamic subtest B-eDP1: SUCCESS (4.620s)
[851.111066] Starting dynamic subtest: C-eDP1
[855.733485] Dynamic subtest C-eDP1: SUCCESS (4.630s)
[855.742919] Starting dynamic subtest: D-eDP1
[860.257946] Dynamic subtest D-eDP1: SUCCESS (4.526s)
[860.260395] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.709s)
[861.133373] [102/131] (159s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[861.237079] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[861.241247] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[861.333740] [103/131] (159s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[861.436370] Starting subtest: fbcpsr-2p-rte
[861.440354] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[861.556087] [104/131] (158s left) kms_psr (fbc-psr2-sprite-plane-move)
[861.658473] Starting subtest: fbc-psr2-sprite-plane-move
[861.660427] Starting dynamic subtest: eDP-1
[861.664589] Dynamic subtest eDP-1: SKIP (0.000s)
[861.668745] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[861.729746] [105/131] (158s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[861.839325] Starting subtest: x-tiled-8bpp-rotate-270
[861.861367] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[862.000395] [106/131] (158s left) kms_addfb_basic (addfb25-modifier-no-flag)
[862.103031] Starting subtest: addfb25-modifier-no-flag
[862.105060] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[862.212336] [107/131] (158s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[862.301699] Starting subtest: bad-aux-stride-yf-tiled-ccs
[862.303708] Starting dynamic subtest: pipe-A-eDP-1
[862.323084] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[862.332933] Starting dynamic subtest: pipe-B-eDP-1
[862.350582] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[862.358587] Starting dynamic subtest: pipe-C-eDP-1
[862.375863] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[862.383639] Starting dynamic subtest: pipe-D-eDP-1
[862.401593] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[862.405082] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[864.509409] [108/131] (156s left) drm_mm (drm_mm)
[864.548632] Starting subtest: drm_mm
[864.593716] Starting dynamic subtest: drm_test_mm_init
[864.692564] Dynamic subtest drm_test_mm_init: SUCCESS (0.099s)
[864.702649] Starting dynamic subtest: drm_test_mm_debug
[864.835419] Dynamic subtest drm_test_mm_debug: SUCCESS (0.141s)
[864.853874] Starting dynamic subtest: drm_test_mm_align32
[864.957332] Dynamic subtest drm_test_mm_align32: SUCCESS (0.123s)
[864.967750] Starting dynamic subtest: drm_test_mm_align64
[865.102074] Dynamic subtest drm_test_mm_align64: SUCCESS (0.144s)
[865.112397] Starting dynamic subtest: drm_test_mm_lowest
[865.245399] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.142s)
[865.255775] Starting dynamic subtest: drm_test_mm_highest
[865.399179] Dynamic subtest drm_test_mm_highest: SUCCESS (0.154s)
[865.401226] Subtest drm_mm: SUCCESS (0.849s)
[865.580619] [109/131] (155s left) syncobj_wait (wait-for-submit-delayed-submit)
[865.636455] Starting subtest: wait-for-submit-delayed-submit
[865.741246] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[865.817460] [110/131] (154s left) gem_render_copy (linear)
[865.874758] Starting subtest: linear
[865.877257] Starting dynamic subtest: smem
[865.915929] Dynamic subtest smem: SUCCESS (0.041s)
[865.918465] Subtest linear: SUCCESS (0.041s)
[866.093411] [111/131] (154s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[866.188727] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[870.514941] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.331s)
[871.707432] [112/131] (149s left) perf_pmu (render-node-busy-idle)
[871.795864] Starting subtest: render-node-busy-idle
[871.798874] Starting dynamic subtest: rcs0
[872.499519] Dynamic subtest rcs0: SUCCESS (0.702s)
[872.512191] Starting dynamic subtest: bcs0
[873.174450] Dynamic subtest bcs0: SUCCESS (0.674s)
[873.185999] Starting dynamic subtest: vcs0
[874.901506] Dynamic subtest vcs0: SUCCESS (1.723s)
[874.913204] Starting dynamic subtest: vcs1
[876.885291] Dynamic subtest vcs1: SUCCESS (1.981s)
[876.897581] Starting dynamic subtest: vecs0
[878.932930] Dynamic subtest vecs0: SUCCESS (2.045s)
[878.944879] Starting dynamic subtest: ccs0
[879.610253] Dynamic subtest ccs0: SUCCESS (0.676s)
[879.612934] Subtest render-node-busy-idle: SUCCESS (7.816s)
[879.685628] [113/131] (141s left) kms_plane_alpha_blend (coverage-7efc)
[879.794280] Starting subtest: coverage-7efc
[880.079398] Starting dynamic subtest: pipe-A-eDP-1
[880.633420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[880.664417] Starting dynamic subtest: pipe-D-eDP-1
[881.892809] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[881.895227] Subtest coverage-7efc: SUCCESS (2.098s)
[882.749224] [114/131] (138s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[882.856546] Starting subtest: yf-tiled-16bpp-rotate-270
[882.861106] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[882.959715] [115/131] (137s left) gem_workarounds (basic-read-context)
[883.031298] Starting subtest: basic-read-context
[883.041291] Subtest basic-read-context: SUCCESS (0.009s)
[883.182630] [116/131] (137s left) gem_exec_fence (invalid-timeline-fence-array)
[883.702224] Starting subtest: invalid-timeline-fence-array
[883.709105] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[884.986735] [117/131] (136s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[885.105057] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[891.732503] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.630s)
[891.835150] [118/131] (129s left) i915_pm_rc6_residency (rc6-idle)
[891.900656] Starting subtest: rc6-idle
[891.956076] Starting dynamic subtest: gt0-rcs0
[916.161136] Dynamic subtest gt0-rcs0: SUCCESS (24.208s)
[916.171717] Starting dynamic subtest: gt0-bcs0
[940.371352] Dynamic subtest gt0-bcs0: SUCCESS (24.208s)
[940.379710] Starting dynamic subtest: gt0-ccs0
[964.647072] Dynamic subtest gt0-ccs0: SUCCESS (24.273s)
[964.658195] Starting dynamic subtest: gt1-vcs0
[970.871420] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[970.883625] Starting dynamic subtest: gt1-vecs0
[977.042986] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[977.045595] Subtest rc6-idle: SUCCESS (85.091s)
[977.086628] [119/131] ( 44s left) syncobj_wait (signal)
[977.140239] Starting subtest: signal
[977.142707] Subtest signal: SUCCESS (0.000s)
[977.244239] [120/131] ( 43s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[977.309777] Starting subtest: multi-wait-available-unsubmitted-submitted
[977.312174] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[977.410936] [121/131] ( 43s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[977.516411] Starting subtest: x-tiled-32bpp-rotate-90
[977.539218] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[977.662211] [122/131] ( 43s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[982.675427] Starting subtest: psr2-overlay-plane-move-continuous-sf
[982.677308] Starting dynamic subtest: pipe-A-eDP-1
[989.390321] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.713s)
[989.400421] Starting dynamic subtest: pipe-B-eDP-1
[996.051460] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.659s)
[996.053808] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.376s)
[996.925440] [123/131] ( 24s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[997.030387] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[997.034613] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[997.147290] [124/131] ( 24s left) kms_sequence (get-forked)
[997.244314] Starting subtest: get-forked
[997.246828] Starting dynamic subtest: pipe-A-eDP-1
[999.112919] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.867s)
[999.122921] Starting dynamic subtest: pipe-B-eDP-1
[1001.650717] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.533s)
[1001.660636] Starting dynamic subtest: pipe-C-eDP-1
[1004.185312] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.535s)
[1004.195100] Starting dynamic subtest: pipe-D-eDP-1
[1006.724911] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s)
[1006.726887] Subtest get-forked: SUCCESS (9.477s)
[1007.562694] [125/131] ( 13s left) gem_exec_fence (syncobj-timeline-signal)
[1008.096095] Starting subtest: syncobj-timeline-signal
[1008.103583] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[1010.005765] [126/131] ( 11s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[1010.117578] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[1010.121648] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[1010.237481] [127/131] ( 11s left) gem_userptr_blits (readonly-unsync)
[1010.314365] Subtest readonly-unsync: SKIP (0.000s)
[1010.449125] [128/131] ( 11s left) kms_universal_plane (cursor-fb-leak)
[1010.539772] Starting subtest: cursor-fb-leak
[1010.542094] Starting dynamic subtest: pipe-A-eDP-1
[1010.859899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.319s)
[1010.871866] Starting dynamic subtest: pipe-B-eDP-1
[1012.174423] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.313s)
[1012.185512] Starting dynamic subtest: pipe-C-eDP-1
[1013.482555] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.304s)
[1013.493234] Starting dynamic subtest: pipe-D-eDP-1
[1014.827052] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[1014.829481] Subtest cursor-fb-leak: SUCCESS (4.287s)
[1016.004886] [129/131] (  5s left) prime_vgem (coherency-gtt)
[1016.087809] Starting subtest: coherency-gtt
[1016.092430] Subtest coherency-gtt: SKIP (0.000s)
[1016.200324] [130/131] (  5s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[1016.299578] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[1016.304067] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[1016.391824] [131/131] (  5s left) gem_pwrite (basic-self)
[1016.455697] Subtest basic-self: SKIP (0.000s)
[1016.514997] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_feature_discovery
results: parsing output: 2/ for test: gem_ctx_shared
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: vgem_basic
results: parsing output: 6/ for test: kms_joiner
results: parsing output: 7/ for test: gem_ctx_isolation
results: parsing output: 8/ for test: i915_query
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: gem_lmem_swapping
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_ppgtt
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_chamelium_color
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: gem_render_copy_redux
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_pipe_crc_basic
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: kms_fence_pin_leak
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_sync
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_getfb
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_spin_batch
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: prime_busy
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: gem_tiled_wc
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: gen9_exec_parse
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_exec_whisper
results: parsing output: 56/ for test: gem_softpin
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_create
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_lease
results: parsing output: 62/ for test: sysfs_timeslice_duration
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: gem_partial_pwrite_pread
results: parsing output: 68/ for test: gen9_exec_parse
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: prime_self_import
results: parsing output: 71/ for test: i915_hangman
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_async_flips
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_pm_rpm
results: parsing output: 79/ for test: gem_gpgpu_fill
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: gem_exec_alignment
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_draw_crc
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_getfb
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: api_intel_allocator
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: api_intel_bb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_mmap_offset
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: kms_chamelium_audio
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: syncobj_eventfd
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: drm_mm
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_plane_alpha_blend
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_workarounds
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: i915_pm_rc6_residency
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_sequence
results: parsing output: 124/ for test: gem_exec_fence
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_universal_plane
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_pwrite
Done.