[58.517827] Initializing watchdogs
[58.517870]   /dev/watchdog0
[58.531508] [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]
[58.535819] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.538182] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.541478] [001/133] (960s left) perf_pmu (busy-start)
[58.605389] Starting subtest: busy-start
[58.607819] Starting dynamic subtest: rcs0
[61.180739] Dynamic subtest rcs0: SUCCESS (2.571s)
[61.189862] Starting dynamic subtest: bcs0
[63.730354] Dynamic subtest bcs0: SUCCESS (2.559s)
[63.739977] Starting dynamic subtest: vcs0
[67.090065] Dynamic subtest vcs0: SUCCESS (3.386s)
[67.100780] Starting dynamic subtest: vcs1
[70.934453] Dynamic subtest vcs1: SUCCESS (3.849s)
[70.942949] Starting dynamic subtest: vecs0
[74.902359] Dynamic subtest vecs0: SUCCESS (3.971s)
[74.910249] Starting dynamic subtest: ccs0
[77.450422] Dynamic subtest ccs0: SUCCESS (2.550s)
[77.452900] Subtest busy-start: SUCCESS (18.893s)
[77.596014] [002/133] (941s left) gem_exec_flush (basic-wb-rw-before-default)
[77.679853] Starting subtest: basic-wb-rw-before-default
[83.170309] Subtest basic-wb-rw-before-default: SUCCESS (5.467s)
[83.336977] [003/133] (935s left) kms_lease (lessee-list)
[83.435768] Starting subtest: lessee-list
[83.438027] Starting dynamic subtest: pipe-A-eDP-1
[83.440335] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[83.449202] Starting dynamic subtest: pipe-B-eDP-1
[83.451075] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[83.458196] Starting dynamic subtest: pipe-C-eDP-1
[83.460070] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[83.466782] Starting dynamic subtest: pipe-D-eDP-1
[83.468725] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[83.470613] Subtest lessee-list: SUCCESS (0.007s)
[83.564553] [004/133] (935s left) i915_drm_fdinfo (virtual-busy-hang-all)
[83.600640] Starting subtest: virtual-busy-hang-all
[83.605054] Subtest virtual-busy-hang-all: SKIP (0.000s)
[83.678246] [005/133] (935s left) kms_atomic_interruptible (legacy-setmode)
[83.771312] Starting subtest: legacy-setmode
[83.773631] Starting dynamic subtest: pipe-A-eDP-1
[90.669271] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.898s)
[90.671703] Subtest legacy-setmode: SUCCESS (6.899s)
[91.544975] [006/133] (927s left) kms_color (ctm-max)
[91.660902] Starting subtest: ctm-max
[91.663078] Starting dynamic subtest: pipe-A-eDP-1
[92.368872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[92.377995] Starting dynamic subtest: pipe-B-eDP-1
[93.769634] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[93.778424] Starting dynamic subtest: pipe-C-eDP-1
[95.118480] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s)
[95.129537] Starting dynamic subtest: pipe-D-eDP-1
[96.481639] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.361s)
[96.483960] Subtest ctm-max: SUCCESS (4.821s)
[97.286936] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[97.394381] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[101.670053] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.279s)
[102.821672] [008/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[102.926936] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[102.931648] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[103.031862] [009/133] (916s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[103.134065] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[103.136443] Starting dynamic subtest: pipe-A
[103.154398] Dynamic subtest pipe-A: SKIP (0.017s)
[103.163396] Starting dynamic subtest: pipe-B
[103.182701] Dynamic subtest pipe-B: SKIP (0.029s)
[103.190431] Starting dynamic subtest: pipe-C
[103.212649] Dynamic subtest pipe-C: SKIP (0.029s)
[103.220264] Starting dynamic subtest: pipe-D
[103.242699] Dynamic subtest pipe-D: SKIP (0.030s)
[103.246975] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.106s)
[103.381346] [010/133] (916s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[103.499348] Starting subtest: y-tiled-64bpp-rotate-180
[103.503594] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[103.631847] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[103.730990] Starting subtest: primary-x-tiled-reflect-x-180
[110.735144] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.004s)
[111.978909] [012/133] (907s left) kms_flip (2x-flip-vs-expired-vblank)
[112.073028] Starting subtest: 2x-flip-vs-expired-vblank
[112.084212] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[112.219372] [013/133] (907s left) api_intel_allocator (fork-simple-stress)
[112.281013] Starting subtest: fork-simple-stress
[117.730595] Subtest fork-simple-stress: SUCCESS (5.398s)
[117.837243] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[117.938148] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[124.519965] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.584s)
[124.650306] [015/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[124.740222] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[124.744306] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[124.849555] [016/133] (894s left) gem_mmap (bad-size)
[124.904749] Subtest bad-size: SKIP (0.000s)
[124.959622] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[125.015480] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[125.020044] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[125.227243] [018/133] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[125.328164] Starting subtest: psr-2p-primscrn-cur-indfb-move
[125.332523] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[125.473830] [019/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[125.578671] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[132.064882] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.491s)
[132.184505] [020/133] (887s left) syncobj_timeline (wait-all-snapshot)
[132.246731] Starting subtest: wait-all-snapshot
[132.327211] Subtest wait-all-snapshot: SUCCESS (0.081s)
[132.425643] [021/133] (887s left) gem_partial_pwrite_pread (reads)
[132.486980] Subtest reads: SKIP (0.000s)
[132.570655] [022/133] (887s left) syncobj_basic (create-signaled)
[132.630065] Starting subtest: create-signaled
[132.632055] Subtest create-signaled: SUCCESS (0.000s)
[132.732793] [023/133] (887s left) kms_chamelium_frames (dp-crc-multiple)
[133.118806] Subtest dp-crc-multiple: SKIP (0.000s)
[133.894400] [024/133] (886s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[134.024494] Starting subtest: cursorA-vs-flipA-varying-size
[145.202054] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.174s)
[146.041302] [025/133] (873s left) gem_ctx_persistence (hang)
[146.108495] Starting subtest: hang
[146.113240] Subtest hang: SKIP (0.000s)
[146.225215] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[146.319535] Starting subtest: pr-primary-page-flip
[146.323912] Subtest pr-primary-page-flip: SKIP (0.000s)
[146.399369] [027/133] (873s left) gem_lmem_swapping (heavy-random)
[146.443332] Subtest heavy-random: SKIP (0.000s)
[146.485958] [028/133] (873s left) kms_addfb_basic (master-rmfb)
[146.542460] Starting subtest: master-rmfb
[146.544500] Subtest master-rmfb: SUCCESS (0.001s)
[146.686696] [029/133] (873s left) kms_addfb_basic (invalid-get-prop-any)
[146.747262] Starting subtest: invalid-get-prop-any
[146.749603] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[146.870151] [030/133] (873s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[146.956107] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[146.958366] Starting dynamic subtest: pipe-A-eDP-1
[146.980530] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.988945] Starting dynamic subtest: pipe-B-eDP-1
[147.009137] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.016450] Starting dynamic subtest: pipe-C-eDP-1
[147.036276] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.044492] Starting dynamic subtest: pipe-D-eDP-1
[147.063558] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.067076] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[149.136642] [031/133] (871s left) gem_exec_basic (basic)
[149.191813] Starting subtest: basic
[149.194168] Starting dynamic subtest: rcs0-smem
[149.196341] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[149.204646] Starting dynamic subtest: bcs0-smem
[149.206969] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[149.214335] Starting dynamic subtest: vcs0-smem
[149.216490] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[149.223680] Starting dynamic subtest: vcs1-smem
[149.225803] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[149.233037] Starting dynamic subtest: vecs0-smem
[149.235211] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[149.242431] Starting dynamic subtest: ccs0-smem
[149.244737] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[149.247027] Subtest basic: SUCCESS (0.019s)
[150.919254] [032/133] (869s left) gem_mmap_offset (oob-read)
[150.978659] Starting subtest: oob-read
[150.981159] Subtest oob-read: SUCCESS (0.000s)
[151.096330] [033/133] (869s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[151.194300] Starting subtest: bad-pixel-format-yf-tiled-ccs
[151.196507] Starting dynamic subtest: pipe-A-eDP-1
[151.218601] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.226778] Starting dynamic subtest: pipe-B-eDP-1
[151.248177] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.255895] Starting dynamic subtest: pipe-C-eDP-1
[151.277542] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.286815] Starting dynamic subtest: pipe-D-eDP-1
[151.308236] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.312114] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[153.414994] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[153.601972] Starting subtest: cursor-random-64x21
[153.647706] Subtest cursor-random-64x21: SKIP (0.039s)
[153.895586] [035/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[153.998054] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[154.001959] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[154.123489] [036/133] (866s left) kms_plane_alpha_blend (constant-alpha-max)
[154.225198] Starting subtest: constant-alpha-max
[154.498307] Starting dynamic subtest: pipe-A-eDP-1
[155.538205] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.039s)
[155.546993] Starting dynamic subtest: pipe-D-eDP-1
[157.118191] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.577s)
[157.120518] Subtest constant-alpha-max: SUCCESS (2.894s)
[158.010345] [037/133] (862s left) gem_exec_fence (keep-in-fence)
[158.205999] Starting subtest: keep-in-fence
[158.208426] Starting dynamic subtest: rcs0
[158.281623] Dynamic subtest rcs0: SUCCESS (0.075s)
[158.291921] Starting dynamic subtest: bcs0
[158.335317] Dynamic subtest bcs0: SUCCESS (0.052s)
[158.345514] Starting dynamic subtest: vcs0
[159.896940] Dynamic subtest vcs0: SUCCESS (1.558s)
[159.908295] Starting dynamic subtest: vcs1
[161.942697] Dynamic subtest vcs1: SUCCESS (2.043s)
[161.954468] Starting dynamic subtest: vecs0
[163.988251] Dynamic subtest vecs0: SUCCESS (1.981s)
[164.008351] Starting dynamic subtest: ccs0
[164.174246] Dynamic subtest ccs0: SUCCESS (0.247s)
[164.177053] Subtest keep-in-fence: SUCCESS (5.969s)
[166.010560] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[166.013399] [038/133] (854s left) i915_pm_rps (min-max-config-idle)
[166.063995] Starting subtest: min-max-config-idle
[166.068804] Subtest min-max-config-idle: SKIP (0.001s)
[166.182466] [039/133] (854s left) dumb_buffer (map-invalid-size)
[166.246302] Starting subtest: map-invalid-size
[166.248660] Subtest map-invalid-size: SUCCESS (0.000s)
[166.379728] [040/133] (854s left) gem_mmap_gtt (basic-write-gtt)
[166.444316] Subtest basic-write-gtt: SKIP (0.000s)
[166.510915] [041/133] (854s left) gem_userptr_blits (set-cache-level)
[166.580832] Starting subtest: set-cache-level
[166.585302] Subtest set-cache-level: SKIP (0.000s)
[166.738582] [042/133] (853s left) kms_psr (psr-primary-render)
[166.849954] Starting subtest: psr-primary-render
[166.852217] Starting dynamic subtest: eDP-1
[168.583212] Dynamic subtest eDP-1: SUCCESS (1.732s)
[168.585549] Subtest psr-primary-render: SUCCESS (1.733s)
[169.456835] [043/133] (851s left) gem_create (create-ext-placement-sanity-check)
[169.635678] Starting subtest: create-ext-placement-sanity-check
[169.641101] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[169.776668] [044/133] (850s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[169.873462] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[169.882021] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[170.018975] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[170.090890] Starting subtest: u-lateslice
[170.092860] Starting dynamic subtest: rcs0
[170.104038] Dynamic subtest rcs0: SUCCESS (0.022s)
[170.112717] Starting dynamic subtest: bcs0
[170.126061] Dynamic subtest bcs0: SUCCESS (0.021s)
[170.134071] Starting dynamic subtest: vcs0
[170.144232] Dynamic subtest vcs0: SUCCESS (0.018s)
[170.152153] Starting dynamic subtest: vcs1
[170.161792] Dynamic subtest vcs1: SUCCESS (0.017s)
[170.169721] Starting dynamic subtest: vecs0
[170.179240] Dynamic subtest vecs0: SUCCESS (0.017s)
[170.187232] Starting dynamic subtest: ccs0
[170.196329] Dynamic subtest ccs0: SUCCESS (0.017s)
[170.198542] Subtest u-lateslice: SUCCESS (0.115s)
[172.042415] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[172.146077] Starting subtest: dpms-off-confusion-interruptible
[172.148232] Starting dynamic subtest: A-eDP1
[180.881413] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[180.891807] Starting dynamic subtest: B-eDP1
[189.524118] Dynamic subtest B-eDP1: SUCCESS (8.642s)
[189.535099] Starting dynamic subtest: C-eDP1
[198.156965] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[198.165591] Starting dynamic subtest: D-eDP1
[206.791257] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[206.793791] Subtest dpms-off-confusion-interruptible: SUCCESS (34.602s)
[207.923307] [047/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[208.018780] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[214.901565] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.884s)
[215.082945] [048/133] (805s left) kms_plane (plane-position-hole)
[215.188346] Starting subtest: plane-position-hole
[215.685290] Starting dynamic subtest: pipe-A-plane-1
[216.985435] Dynamic subtest pipe-A-plane-1: SUCCESS (1.301s)
[216.995709] Starting dynamic subtest: pipe-A-plane-2
[218.245760] Dynamic subtest pipe-A-plane-2: SUCCESS (1.260s)
[218.254490] Starting dynamic subtest: pipe-A-plane-3
[219.486625] Dynamic subtest pipe-A-plane-3: SUCCESS (1.240s)
[219.496910] Starting dynamic subtest: pipe-A-plane-4
[220.716480] Dynamic subtest pipe-A-plane-4: SUCCESS (1.229s)
[220.724794] Starting dynamic subtest: pipe-A-plane-5
[220.744195] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[221.871186] Starting dynamic subtest: pipe-B-plane-1
[223.207061] Dynamic subtest pipe-B-plane-1: SUCCESS (1.344s)
[223.215351] Starting dynamic subtest: pipe-B-plane-2
[224.489610] Dynamic subtest pipe-B-plane-2: SUCCESS (1.282s)
[224.499140] Starting dynamic subtest: pipe-B-plane-3
[225.736942] Dynamic subtest pipe-B-plane-3: SUCCESS (1.244s)
[225.745798] Starting dynamic subtest: pipe-B-plane-4
[226.950879] Dynamic subtest pipe-B-plane-4: SUCCESS (1.215s)
[226.959084] Starting dynamic subtest: pipe-B-plane-5
[226.978418] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[226.980739] Subtest plane-position-hole: SUCCESS (11.790s)
[227.772320] [049/133] (793s left) kms_draw_crc (draw-method-mmap-cpu)
[227.875847] Starting subtest: draw-method-mmap-cpu
[227.877705] Starting dynamic subtest: xrgb8888-untiled
[228.108287] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[228.118828] Starting dynamic subtest: rgb565-untiled
[228.319085] Dynamic subtest rgb565-untiled: SUCCESS (0.208s)
[228.327562] Starting dynamic subtest: xrgb2101010-untiled
[228.507876] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.188s)
[228.516164] Starting dynamic subtest: xbgr16161616f-untiled
[228.729819] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[228.738168] Starting dynamic subtest: xrgb8888-xtiled
[228.863145] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[228.871116] Starting dynamic subtest: rgb565-xtiled
[228.985063] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[228.993065] Starting dynamic subtest: xrgb2101010-xtiled
[229.096308] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[229.106269] Starting dynamic subtest: xbgr16161616f-xtiled
[229.218773] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.120s)
[229.226750] Starting dynamic subtest: xrgb8888-4tiled
[229.363100] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[229.371390] Starting dynamic subtest: rgb565-4tiled
[229.507578] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[229.518733] Starting dynamic subtest: xrgb2101010-4tiled
[229.629943] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[229.637924] Starting dynamic subtest: xbgr16161616f-4tiled
[229.763184] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[229.765142] Subtest draw-method-mmap-cpu: SUCCESS (1.889s)
[229.904066] [050/133] (791s left) gem_mmap_gtt (medium-copy-xy)
[229.970522] Subtest medium-copy-XY: SKIP (0.000s)
[230.040322] [051/133] (790s left) vgem_basic (bad-flag)
[230.084673] Starting subtest: bad-flag
[230.086350] Subtest bad-flag: SUCCESS (0.000s)
[230.152292] [052/133] (790s left) gem_ctx_persistence (engines-hostile-preempt)
[230.223432] Starting subtest: engines-hostile-preempt
[230.225439] Starting dynamic subtest: rcs0
[230.335883] Dynamic subtest rcs0: SUCCESS (0.111s)
[230.346725] Starting dynamic subtest: bcs0
[230.408700] Dynamic subtest bcs0: SUCCESS (0.071s)
[230.419473] Starting dynamic subtest: vcs0
[231.897628] Dynamic subtest vcs0: SUCCESS (1.485s)
[231.912242] Starting dynamic subtest: vcs1
[233.887266] Dynamic subtest vcs1: SUCCESS (1.987s)
[233.898612] Starting dynamic subtest: vecs0
[235.994033] Dynamic subtest vecs0: SUCCESS (2.051s)
[236.004666] Starting dynamic subtest: ccs0
[236.014313] Dynamic subtest ccs0: SUCCESS (0.072s)
[236.016681] Subtest engines-hostile-preempt: SUCCESS (5.792s)
[236.108891] [053/133] (784s left) kms_sequence (queue-idle)
[236.211808] Starting subtest: queue-idle
[236.213945] Starting dynamic subtest: pipe-A-eDP-1
[237.997971] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.785s)
[238.006324] Starting dynamic subtest: pipe-B-eDP-1
[240.420881] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.423s)
[240.429490] Starting dynamic subtest: pipe-C-eDP-1
[242.848174] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.424s)
[242.856665] Starting dynamic subtest: pipe-D-eDP-1
[245.270574] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.422s)
[245.272964] Subtest queue-idle: SUCCESS (9.060s)
[246.120209] [054/133] (774s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[246.231360] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[246.233792] Starting dynamic subtest: pipe-A-eDP-1
[246.301838] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[246.312785] Starting dynamic subtest: pipe-B-eDP-1
[247.473505] Dynamic subtest pipe-B-eDP-1: SKIP (1.169s)
[247.478115] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.248s)
[248.673523] [055/133] (772s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[248.776469] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[248.780695] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[248.886208] [056/133] (772s left) kms_atomic (atomic-plane-damage)
[248.978082] Starting subtest: atomic-plane-damage
[249.027473] Starting dynamic subtest: pipe-A-eDP-1
[249.565604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.539s)
[249.567757] Subtest atomic-plane-damage: SUCCESS (0.588s)
[250.410714] [057/133] (770s left) kms_big_fb (linear-16bpp-rotate-90)
[250.513404] Starting subtest: linear-16bpp-rotate-90
[250.535272] Subtest linear-16bpp-rotate-90: SKIP (0.021s)
[250.685363] [058/133] (770s left) perf (stress-open-close)
[250.816116] Starting subtest: stress-open-close
[250.818202] Starting dynamic subtest: 0-rcs0
[252.978871] Dynamic subtest 0-rcs0: SUCCESS (2.164s)
[252.986788] Starting dynamic subtest: 1-vcs1
[255.142230] Dynamic subtest 1-vcs1: SUCCESS (2.162s)
[255.144120] Subtest stress-open-close: SUCCESS (4.329s)
[255.180547] [059/133] (766s left) gem_workarounds (basic-read-fd)
[255.259906] Starting subtest: basic-read-fd
[255.278413] Subtest basic-read-fd: SUCCESS (0.018s)
[255.429039] [060/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[255.533616] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[256.568213] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.034s)
[256.713402] [061/133] (764s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[256.817463] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[256.820879] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[256.934018] [062/133] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[257.028343] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[257.031877] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[257.122409] [063/133] (764s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[257.228164] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[257.231510] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[257.346519] [064/133] (764s left) kms_cursor_crc (cursor-offscreen-32x10)
[257.514207] Starting subtest: cursor-offscreen-32x10
[257.558565] Subtest cursor-offscreen-32x10: SKIP (0.039s)
[257.858017] [065/133] (763s left) kms_psr (psr2-primary-render)
[257.947505] Starting subtest: psr2-primary-render
[257.949493] Starting dynamic subtest: eDP-1
[259.683568] Dynamic subtest eDP-1: SUCCESS (1.736s)
[259.685979] Subtest psr2-primary-render: SUCCESS (1.737s)
[260.572008] [066/133] (761s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[260.687614] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[260.691678] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[260.807394] [067/133] (760s left) gem_exec_schedule (noreorder-priority)
[260.987122] Starting subtest: noreorder-priority
[260.989730] Starting dynamic subtest: rcs0
[262.139326] Dynamic subtest rcs0: SUCCESS (1.152s)
[262.153619] Starting dynamic subtest: vcs0
[263.909660] Dynamic subtest vcs0: SUCCESS (1.767s)
[263.921704] Starting dynamic subtest: vcs1
[265.964539] Dynamic subtest vcs1: SUCCESS (2.053s)
[265.976094] Starting dynamic subtest: vecs0
[267.950747] Dynamic subtest vecs0: SUCCESS (1.984s)
[267.962391] Starting dynamic subtest: ccs0
[269.121068] Dynamic subtest ccs0: SUCCESS (1.169s)
[269.124023] Subtest noreorder-priority: SUCCESS (8.136s)
[269.315033] [068/133] (752s left) gem_softpin (allocator-evict)
[269.365498] Starting subtest: allocator-evict
[269.367904] Starting dynamic subtest: rcs0
[293.256067] Dynamic subtest rcs0: SUCCESS (23.888s)
[293.267807] Starting dynamic subtest: bcs0
[317.263707] Dynamic subtest bcs0: SUCCESS (24.005s)
[317.272339] Starting dynamic subtest: vcs0
[340.993791] Dynamic subtest vcs0: SUCCESS (23.728s)
[341.004254] Starting dynamic subtest: vcs1
[364.707040] Dynamic subtest vcs1: SUCCESS (23.711s)
[364.717999] Starting dynamic subtest: vecs0
[388.422511] Dynamic subtest vecs0: SUCCESS (23.712s)
[388.431833] Starting dynamic subtest: ccs0
[411.919833] Dynamic subtest ccs0: SUCCESS (23.495s)
[411.922242] Subtest allocator-evict: SUCCESS (142.549s)
[412.012222] [069/133] (609s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[412.176681] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[417.056390] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.882s)
[418.278118] [070/133] (603s left) gem_exec_reloc (basic-cpu-gtt-active)
[418.354816] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[418.430983] [071/133] (603s left) gem_ctx_shared (single-timeline)
[418.494526] Starting subtest: single-timeline
[418.511750] Subtest single-timeline: SUCCESS (0.015s)
[418.759259] [072/133] (603s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[418.821398] Starting subtest: etime-multi-wait-all-for-submit-submitted
[418.930869] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[419.019661] [073/133] (602s left) syncobj_timeline (etime-single-wait-all-submitted)
[419.093425] Starting subtest: etime-single-wait-all-submitted
[419.194303] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[419.284494] [074/133] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[419.676270] Subtest dp-hpd-storm: SKIP (0.000s)
[420.467851] [075/133] (601s left) kms_flip (2x-flip-vs-suspend)
[420.571146] Starting subtest: 2x-flip-vs-suspend
[420.579365] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[420.723183] [076/133] (601s left) kms_psr (fbc-psr2-sprite-plane-move)
[420.829827] Starting subtest: fbc-psr2-sprite-plane-move
[420.832070] Starting dynamic subtest: eDP-1
[420.836120] Dynamic subtest eDP-1: SKIP (0.000s)
[420.840251] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[420.916347] [077/133] (601s left) gem_exec_params (mmapped)
[420.967503] Starting subtest: mmapped
[420.972431] Subtest mmapped: SUCCESS (0.002s)
[421.115945] [078/133] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[421.217589] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[421.222066] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[421.333942] [079/133] (600s left) sw_sync (sync_merge_invalid)
[421.378198] Starting subtest: sync_merge_invalid
[421.401228] Subtest sync_merge_invalid: SUCCESS (0.023s)
[421.492145] [080/133] (600s left) perf_pmu (busy)
[421.528944] Starting subtest: busy
[421.530755] Starting dynamic subtest: rcs0
[422.141945] Dynamic subtest rcs0: SUCCESS (0.613s)
[422.153137] Starting dynamic subtest: bcs0
[422.710948] Dynamic subtest bcs0: SUCCESS (0.567s)
[422.722282] Starting dynamic subtest: vcs0
[423.896454] Dynamic subtest vcs0: SUCCESS (1.181s)
[423.907038] Starting dynamic subtest: vcs1
[425.878061] Dynamic subtest vcs1: SUCCESS (1.979s)
[425.889754] Starting dynamic subtest: vecs0
[427.926931] Dynamic subtest vecs0: SUCCESS (2.046s)
[427.938740] Starting dynamic subtest: ccs0
[428.502355] Dynamic subtest ccs0: SUCCESS (0.574s)
[428.504895] Subtest busy: SUCCESS (6.974s)
[428.633110] [081/133] (593s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[428.689992] Starting subtest: multi-wait-for-submit-submitted-signaled
[428.692357] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[428.840809] [082/133] (593s left) gem_mmap_wc (write-wc-read-gtt)
[428.916255] Subtest write-wc-read-gtt: SKIP (0.000s)
[428.986160] [083/133] (593s left) kms_hdmi_inject (inject-audio)
[429.336833] Starting subtest: inject-audio
[429.630840] Subtest inject-audio: SUCCESS (0.296s)
[430.179135] [084/133] (592s left) kms_flip (2x-blocking-wf_vblank)
[430.291102] Starting subtest: 2x-blocking-wf_vblank
[430.303184] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[430.440906] [085/133] (591s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[430.538275] Starting subtest: plane-all-transition-nonblocking-fencing
[430.540535] Starting dynamic subtest: pipe-A-eDP-1
[433.032843] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[433.339436] Starting dynamic subtest: pipe-B-eDP-1
[436.526031] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.197s)
[436.826953] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.287s)
[437.637815] [086/133] (584s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[437.778853] Starting subtest: flip-vs-cursor-crc-legacy
[438.454410] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.673s)
[439.327642] [087/133] (583s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[439.425132] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[439.429577] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[439.507558] [088/133] (583s left) gem_exec_params (invalid-ring2)
[439.578473] Starting subtest: invalid-ring2
[439.580829] Subtest invalid-ring2: SUCCESS (0.000s)
[439.701764] [089/133] (582s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[439.800727] Starting subtest: fbcpsr-slowdraw
[464.862714] Subtest fbcpsr-slowdraw: SUCCESS (25.062s)
[465.017302] [090/133] (557s left) kms_joiner (basic-force-ultra-joiner)
[465.120744] Starting subtest: basic-force-ultra-joiner
[465.125411] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[465.205050] [091/133] (557s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[465.299098] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[465.325456] Starting dynamic subtest: pipe-A-plane-0
[465.614312] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[465.622963] Starting dynamic subtest: pipe-A-plane-3
[465.846874] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[466.977722] Starting dynamic subtest: pipe-B-plane-0
[467.270023] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[467.279626] Starting dynamic subtest: pipe-B-plane-3
[467.503998] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[467.809920] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.512s)
[468.630182] [092/133] (554s left) kms_vblank (query-forked-busy-hang)
[468.728872] Starting subtest: query-forked-busy-hang
[468.731127] Starting dynamic subtest: pipe-A-eDP-1
[494.681086] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.949s)
[494.695492] Starting dynamic subtest: pipe-D-eDP-1
[519.710547] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.026s)
[519.712476] Subtest query-forked-busy-hang: SUCCESS (50.980s)
[520.562854] [093/133] (502s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[520.680298] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[520.684557] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[520.793543] [094/133] (502s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[520.890888] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[521.470559] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.581s)
[521.659237] [095/133] (501s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[521.760128] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[521.762350] Starting dynamic subtest: pipe-A-default-mode
[524.500496] Dynamic subtest pipe-A-default-mode: SUCCESS (2.739s)
[524.502452] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.740s)
[525.320185] [096/133] (497s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[525.380300] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[525.481546] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[525.582165] [097/133] (497s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[525.702039] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[525.706297] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[525.811331] [098/133] (497s left) gem_exec_whisper (basic-fds-forked)
[525.875624] Starting subtest: basic-fds-forked
[549.224995] Subtest basic-fds-forked: SUCCESS (23.348s)
[549.420808] [099/133] (473s left) kms_addfb_basic (bad-pitch-999)
[549.480601] Starting subtest: bad-pitch-999
[549.482823] Subtest bad-pitch-999: SUCCESS (0.000s)
[549.649066] [100/133] (473s left) kms_prop_blob (basic)
[549.697720] Starting subtest: basic
[549.699690] Subtest basic: SUCCESS (0.000s)
[549.814892] [101/133] (473s left) syncobj_basic (bad-pad-fd-to-handle)
[549.878661] Starting subtest: bad-pad-fd-to-handle
[549.881032] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[549.984781] [102/133] (473s left) kms_cursor_crc (cursor-sliding-256x256)
[550.219714] Starting subtest: cursor-sliding-256x256
[550.221932] Starting dynamic subtest: pipe-A-eDP-1
[553.486724] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.263s)
[553.515272] Starting dynamic subtest: pipe-D-eDP-1
[557.439025] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.930s)
[557.441314] Subtest cursor-sliding-256x256: SUCCESS (7.218s)
[558.317383] [103/133] (464s left) gem_busy (busy)
[558.380390] Starting subtest: busy
[558.382762] Starting dynamic subtest: all-engines
[558.460627] Dynamic subtest all-engines: SUCCESS (0.079s)
[558.471845] Starting dynamic subtest: rcs0
[559.902711] Dynamic subtest rcs0: SUCCESS (1.439s)
[559.914428] Starting dynamic subtest: bcs0
[559.971036] Dynamic subtest bcs0: SUCCESS (0.067s)
[559.981572] Starting dynamic subtest: vcs0
[560.009945] Dynamic subtest vcs0: SUCCESS (0.038s)
[560.019488] Starting dynamic subtest: vcs1
[561.885518] Dynamic subtest vcs1: SUCCESS (1.870s)
[561.896832] Starting dynamic subtest: vecs0
[563.984975] Dynamic subtest vecs0: SUCCESS (2.045s)
[563.996160] Starting dynamic subtest: ccs0
[565.915618] Dynamic subtest ccs0: SUCCESS (1.983s)
[565.917926] Subtest busy: SUCCESS (7.533s)
[566.291976] [104/133] (456s left) i915_pm_rps (thresholds)
[566.352750] Starting subtest: thresholds
[566.357249] Subtest thresholds: SKIP (0.001s)
[566.499070] [105/133] (456s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[566.598731] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[566.600831] Starting dynamic subtest: pipe-A-eDP-1
[566.622570] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[566.633935] Starting dynamic subtest: pipe-B-eDP-1
[566.654216] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[566.662707] Starting dynamic subtest: pipe-C-eDP-1
[566.683252] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[566.691673] Starting dynamic subtest: pipe-D-eDP-1
[566.713789] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[566.717803] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[568.826023] [106/133] (454s left) gem_softpin (evict-snoop-interruptible)
[568.898098] Starting subtest: evict-snoop-interruptible
[568.902924] Subtest evict-snoop-interruptible: SKIP (0.000s)
[569.034631] [107/133] (454s left) gem_mmap_gtt (big-bo)
[569.096873] Subtest big-bo: SKIP (0.000s)
[569.160821] [108/133] (454s left) gem_partial_pwrite_pread (write-display)
[569.214467] Subtest write-display: SKIP (0.000s)
[569.306768] [109/133] (454s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[569.400202] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[569.402514] Starting dynamic subtest: pipe-A-eDP-1
[569.425891] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[569.437750] Starting dynamic subtest: pipe-B-eDP-1
[569.459603] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[569.467962] Starting dynamic subtest: pipe-C-eDP-1
[569.489715] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[569.497942] Starting dynamic subtest: pipe-D-eDP-1
[569.520489] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[569.524987] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[571.622675] [110/133] (451s left) kms_psr (fbc-pr-cursor-blt)
[571.717095] Starting subtest: fbc-pr-cursor-blt
[571.721593] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[571.799162] [111/133] (451s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[571.857600] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[571.859602] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[571.979722] [112/133] (451s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[572.043757] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[572.049652] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[572.241287] [113/133] (451s left) gem_mmap (basic)
[572.307059] Subtest basic: SKIP (0.000s)
[572.380888] [114/133] (451s left) gem_exec_gttfill (basic)
[572.459061] Starting subtest: basic
[575.499042] Subtest basic: SUCCESS (3.038s)
[575.704335] [115/133] (447s left) kms_addfb_basic (size-max)
[575.857895] Starting subtest: size-max
[575.860188] Subtest size-max: SUCCESS (0.000s)
[575.980297] [116/133] (447s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[576.087284] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[576.089600] Starting dynamic subtest: pipe-A-eDP-1
[576.111263] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[576.122926] Starting dynamic subtest: pipe-B-eDP-1
[576.145754] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[576.156572] Starting dynamic subtest: pipe-C-eDP-1
[576.177681] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[576.186811] Starting dynamic subtest: pipe-D-eDP-1
[576.208964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[576.213025] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[578.334253] [117/133] (445s left) api_intel_bb (purge-bb)
[578.385678] Starting subtest: purge-bb
[578.387741] Subtest purge-bb: SUCCESS (0.004s)
[578.533518] [118/133] (445s left) kms_cursor_legacy (forked-move)
[578.655630] Starting subtest: forked-move
[578.657813] Starting dynamic subtest: pipe-A
[584.108865] Dynamic subtest pipe-A: SUCCESS (5.451s)
[584.120516] Starting dynamic subtest: pipe-B
[589.635304] Dynamic subtest pipe-B: SUCCESS (5.470s)
[589.645067] Starting dynamic subtest: pipe-C
[595.091386] Dynamic subtest pipe-C: SUCCESS (5.456s)
[595.101186] Starting dynamic subtest: pipe-D
[600.570756] Dynamic subtest pipe-D: SUCCESS (5.478s)
[600.584384] Starting dynamic subtest: all-pipes
[606.057952] Dynamic subtest all-pipes: SUCCESS (5.483s)
[606.060362] Subtest forked-move: SUCCESS (27.349s)
[606.177422] [119/133] (417s left) gen9_exec_parse (bb-chained)
[606.249682] Subtest bb-chained: SKIP (0.000s)
[606.326570] [120/133] (417s left) kms_concurrent (multi-plane-atomic-lowres)
[606.421127] Starting subtest: multi-plane-atomic-lowres
[606.423309] Starting dynamic subtest: pipe-A-eDP-1
[606.906988] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.482s)
[606.909365] Subtest multi-plane-atomic-lowres: SUCCESS (0.484s)
[607.764710] [121/133] (416s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[607.834080] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[607.912552] [122/133] (416s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[607.971577] Starting subtest: multi-wait-available-unsubmitted-submitted
[607.974078] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[608.101012] [123/133] (415s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[608.190788] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[612.609869] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.423s)
[613.824587] [124/133] (410s left) kms_pm_dc (dc3co-vpb-simulation)
[614.937132] Starting subtest: dc3co-vpb-simulation
[623.674623] Subtest dc3co-vpb-simulation: SKIP (8.682s)
[623.786830] [125/133] (400s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[623.892765] Starting subtest: x-tiled-8bpp-rotate-90
[623.913983] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[624.062534] [126/133] (400s left) kms_plane_multiple (2x-tiling-none)
[624.162782] Starting subtest: 2x-tiling-none
[624.166637] Subtest 2x-tiling-none: SKIP (0.000s)
[624.244637] [127/133] (399s left) gem_exec_balancer (bonded-false-hang)
[624.503307] Starting subtest: bonded-false-hang
[624.508089] Subtest bonded-false-hang: SKIP (0.000s)
[624.634810] [128/133] (399s left) i915_drm_fdinfo (idle)
[624.673660] Starting subtest: idle
[624.675863] Starting dynamic subtest: rcs0
[625.283416] Dynamic subtest rcs0: SUCCESS (0.610s)
[625.299720] Starting dynamic subtest: bcs0
[625.791365] Dynamic subtest bcs0: SUCCESS (0.504s)
[625.803808] Starting dynamic subtest: vcs0
[626.297107] Dynamic subtest vcs0: SUCCESS (0.503s)
[626.308521] Starting dynamic subtest: vcs1
[626.802768] Dynamic subtest vcs1: SUCCESS (0.503s)
[626.814410] Starting dynamic subtest: vecs0
[627.307784] Dynamic subtest vecs0: SUCCESS (0.503s)
[627.318779] Starting dynamic subtest: ccs0
[627.812959] Dynamic subtest ccs0: SUCCESS (0.503s)
[627.815656] Subtest idle: SUCCESS (3.141s)
[627.899899] [129/133] (396s left) kms_getfb (getfb2-handle-closed)
[628.010179] Starting subtest: getfb2-handle-closed
[628.012353] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[628.148174] [130/133] (396s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[628.211523] Starting subtest: invalid-bsd1-flag-on-vebox
[628.213861] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[628.323266] [131/133] (396s left) kms_psr (fbc-pr-suspend)
[628.424768] Starting subtest: fbc-pr-suspend
[628.429042] Subtest fbc-pr-suspend: SKIP (0.000s)
[628.510158] [132/133] (395s left) gem_softpin (overlap)
[628.579402] Starting subtest: overlap
[629.430522] Subtest overlap: SUCCESS (0.853s)
[629.570325] [133/133] (394s left) gem_madvise (dontneed-before-mmap)
[629.601950] Starting subtest: dontneed-before-mmap
[629.622772] Subtest dontneed-before-mmap: SUCCESS (0.020s)
[629.742222] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_flush
results: parsing output: 2/ for test: kms_lease
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: kms_atomic_interruptible
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: api_intel_allocator
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_partial_pwrite_pread
results: parsing output: 21/ for test: syncobj_basic
results: parsing output: 22/ for test: kms_chamelium_frames
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_basic
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_plane_alpha_blend
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: i915_pm_rps
results: parsing output: 38/ for test: dumb_buffer
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_draw_crc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: vgem_basic
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_softpin
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: gem_ctx_shared
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_hdmi_inject
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_joiner
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_vblank
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_prop_blob
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_busy
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_softpin
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: gem_partial_pwrite_pread
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: gem_mmap
results: parsing output: 113/ for test: gem_exec_gttfill
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: kms_concurrent
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pm_dc
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: kms_getfb
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: gem_madvise
Done.