[57.897048] Initializing watchdogs
[57.897094]   /dev/watchdog0
[57.910494] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.914752] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.916854] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.919919] [001/133] (960s left) perf_pmu (busy-start)
[57.981211] Starting subtest: busy-start
[57.983526] Starting dynamic subtest: rcs0
[60.544083] Dynamic subtest rcs0: SUCCESS (2.547s)
[60.553905] Starting dynamic subtest: bcs0
[63.102860] Dynamic subtest bcs0: SUCCESS (2.547s)
[63.109818] Starting dynamic subtest: vcs0
[67.057264] Dynamic subtest vcs0: SUCCESS (3.943s)
[67.065635] Starting dynamic subtest: vcs1
[70.931755] Dynamic subtest vcs1: SUCCESS (3.867s)
[70.941487] Starting dynamic subtest: vecs0
[74.900586] Dynamic subtest vecs0: SUCCESS (3.964s)
[74.908883] Starting dynamic subtest: ccs0
[77.448656] Dynamic subtest ccs0: SUCCESS (2.548s)
[77.451107] Subtest busy-start: SUCCESS (19.421s)
[77.548981] [002/133] (940s left) gem_exec_flush (basic-wb-rw-before-default)
[77.601721] Starting subtest: basic-wb-rw-before-default
[83.056367] Subtest basic-wb-rw-before-default: SUCCESS (5.453s)
[83.258870] [003/133] (935s left) kms_lease (lessee-list)
[83.350291] Starting subtest: lessee-list
[83.352678] Starting dynamic subtest: pipe-A-eDP-1
[83.355054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[83.364348] Starting dynamic subtest: pipe-B-eDP-1
[83.366510] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[83.373643] Starting dynamic subtest: pipe-C-eDP-1
[83.375852] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[83.382988] Starting dynamic subtest: pipe-D-eDP-1
[83.385247] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[83.387375] Subtest lessee-list: SUCCESS (0.008s)
[83.478161] [004/133] (935s left) i915_drm_fdinfo (virtual-busy-hang-all)
[83.524125] Starting subtest: virtual-busy-hang-all
[83.528332] Subtest virtual-busy-hang-all: SKIP (0.000s)
[83.602945] [005/133] (934s left) kms_atomic_interruptible (legacy-setmode)
[83.714579] Starting subtest: legacy-setmode
[83.716833] Starting dynamic subtest: pipe-A-eDP-1
[90.618110] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.901s)
[90.620501] Subtest legacy-setmode: SUCCESS (6.902s)
[91.431726] [006/133] (927s left) kms_color (ctm-max)
[91.530277] Starting subtest: ctm-max
[91.532132] Starting dynamic subtest: pipe-A-eDP-1
[92.236395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[92.245567] Starting dynamic subtest: pipe-B-eDP-1
[93.671289] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[93.685797] Starting dynamic subtest: pipe-C-eDP-1
[95.002777] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.333s)
[95.011879] Starting dynamic subtest: pipe-D-eDP-1
[96.335096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[96.337353] Subtest ctm-max: SUCCESS (4.804s)
[97.166593] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[97.285780] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[101.491487] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.209s)
[102.654335] [008/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[102.759080] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[102.763170] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[102.883588] [009/133] (915s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[102.968665] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[102.970901] Starting dynamic subtest: pipe-A
[102.996741] Dynamic subtest pipe-A: SKIP (0.023s)
[103.004707] Starting dynamic subtest: pipe-B
[103.027996] Dynamic subtest pipe-B: SKIP (0.032s)
[103.035628] Starting dynamic subtest: pipe-C
[103.059093] Dynamic subtest pipe-C: SKIP (0.030s)
[103.067648] Starting dynamic subtest: pipe-D
[103.088041] Dynamic subtest pipe-D: SKIP (0.029s)
[103.091590] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.115s)
[103.228241] [010/133] (915s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[103.338076] Starting subtest: y-tiled-64bpp-rotate-180
[103.342239] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[103.463035] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[103.562989] Starting subtest: primary-x-tiled-reflect-x-180
[110.457514] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.895s)
[111.698156] [012/133] (907s left) kms_flip (2x-flip-vs-expired-vblank)
[111.809903] Starting subtest: 2x-flip-vs-expired-vblank
[111.820051] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[111.906980] [013/133] (906s left) api_intel_allocator (fork-simple-stress)
[111.957878] Starting subtest: fork-simple-stress
[117.384240] Subtest fork-simple-stress: SUCCESS (5.426s)
[117.529206] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[117.642894] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[124.145209] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.504s)
[124.289470] [015/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[124.405776] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[124.410210] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[124.536603] [016/133] (894s left) gem_mmap (bad-size)
[124.612332] Subtest bad-size: SKIP (0.000s)
[124.673751] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[124.748951] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[124.753647] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[124.938865] [018/133] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[125.044241] Starting subtest: psr-2p-primscrn-cur-indfb-move
[125.048288] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[125.160141] [019/133] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[125.266477] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[131.721751] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.458s)
[131.866208] [020/133] (887s left) syncobj_timeline (wait-all-snapshot)
[131.933704] Starting subtest: wait-all-snapshot
[132.016312] Subtest wait-all-snapshot: SUCCESS (0.081s)
[132.100139] [021/133] (887s left) gem_partial_pwrite_pread (reads)
[132.168206] Subtest reads: SKIP (0.000s)
[132.257117] [022/133] (886s left) syncobj_basic (create-signaled)
[132.322260] Starting subtest: create-signaled
[132.324574] Subtest create-signaled: SUCCESS (0.000s)
[132.436493] [023/133] (886s left) kms_chamelium_frames (dp-crc-multiple)
[132.837808] Subtest dp-crc-multiple: SKIP (0.000s)
[133.641436] [024/133] (885s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[133.770560] Starting subtest: cursorA-vs-flipA-varying-size
[144.940724] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.168s)
[145.804220] [025/133] (873s left) gem_ctx_persistence (hang)
[145.859661] Starting subtest: hang
[145.864140] Subtest hang: SKIP (0.000s)
[145.976858] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[146.061100] Starting subtest: pr-primary-page-flip
[146.065302] Subtest pr-primary-page-flip: SKIP (0.000s)
[146.139388] [027/133] (873s left) gem_lmem_swapping (heavy-random)
[146.182738] Subtest heavy-random: SKIP (0.000s)
[146.232964] [028/133] (873s left) kms_addfb_basic (master-rmfb)
[146.277709] Starting subtest: master-rmfb
[146.279772] Subtest master-rmfb: SUCCESS (0.001s)
[146.442297] [029/133] (873s left) kms_addfb_basic (invalid-get-prop-any)
[146.492529] Starting subtest: invalid-get-prop-any
[146.494749] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[146.681109] [030/133] (872s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[146.779460] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[146.781275] Starting dynamic subtest: pipe-A-eDP-1
[146.802023] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.811801] Starting dynamic subtest: pipe-B-eDP-1
[146.830500] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[146.837687] Starting dynamic subtest: pipe-C-eDP-1
[146.856682] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[146.864657] Starting dynamic subtest: pipe-D-eDP-1
[146.884082] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[146.887624] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[148.988077] [031/133] (870s left) gem_exec_basic (basic)
[149.047182] Starting subtest: basic
[149.049517] Starting dynamic subtest: rcs0-smem
[149.051940] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[149.060471] Starting dynamic subtest: bcs0-smem
[149.062761] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[149.069908] Starting dynamic subtest: vcs0-smem
[149.071756] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[149.078462] Starting dynamic subtest: vcs1-smem
[149.080364] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[149.087103] Starting dynamic subtest: vecs0-smem
[149.088958] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[149.095604] Starting dynamic subtest: ccs0-smem
[149.097488] Dynamic subtest ccs0-smem: SUCCESS (0.004s)
[149.099413] Subtest basic: SUCCESS (0.020s)
[150.982360] [032/133] (868s left) gem_mmap_offset (oob-read)
[151.039921] Starting subtest: oob-read
[151.042113] Subtest oob-read: SUCCESS (0.000s)
[151.158499] [033/133] (868s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[151.253139] Starting subtest: bad-pixel-format-yf-tiled-ccs
[151.255304] Starting dynamic subtest: pipe-A-eDP-1
[151.277719] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.287336] Starting dynamic subtest: pipe-B-eDP-1
[151.308242] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.315626] Starting dynamic subtest: pipe-C-eDP-1
[151.336529] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.343987] Starting dynamic subtest: pipe-D-eDP-1
[151.365306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.369214] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[153.445776] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[153.621849] Starting subtest: cursor-random-64x21
[153.665154] Subtest cursor-random-64x21: SKIP (0.039s)
[153.951022] [035/133] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[154.054509] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[154.058866] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[154.176678] [036/133] (865s left) kms_plane_alpha_blend (constant-alpha-max)
[154.276262] Starting subtest: constant-alpha-max
[154.554963] Starting dynamic subtest: pipe-A-eDP-1
[155.480412] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.923s)
[155.489019] Starting dynamic subtest: pipe-D-eDP-1
[157.050220] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.567s)
[157.052406] Subtest constant-alpha-max: SUCCESS (2.772s)
[157.917893] [037/133] (861s left) gem_exec_fence (keep-in-fence)
[158.097047] Starting subtest: keep-in-fence
[158.099728] Starting dynamic subtest: rcs0
[158.177955] Dynamic subtest rcs0: SUCCESS (0.080s)
[158.188341] Starting dynamic subtest: bcs0
[158.232557] Dynamic subtest bcs0: SUCCESS (0.053s)
[158.243043] Starting dynamic subtest: vcs0
[159.894726] Dynamic subtest vcs0: SUCCESS (1.658s)
[159.905852] Starting dynamic subtest: vcs1
[161.877558] Dynamic subtest vcs1: SUCCESS (1.980s)
[161.888075] Starting dynamic subtest: vecs0
[163.925575] Dynamic subtest vecs0: SUCCESS (2.047s)
[163.935765] Starting dynamic subtest: ccs0
[164.163991] Dynamic subtest ccs0: SUCCESS (0.237s)
[164.166950] Subtest keep-in-fence: SUCCESS (6.068s)
[165.988020] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[165.991261] [038/133] (853s left) i915_pm_rps (min-max-config-idle)
[166.054294] Starting subtest: min-max-config-idle
[166.058867] Subtest min-max-config-idle: SKIP (0.001s)
[166.182550] [039/133] (853s left) dumb_buffer (map-invalid-size)
[166.239542] Starting subtest: map-invalid-size
[166.241872] Subtest map-invalid-size: SUCCESS (0.000s)
[166.349440] [040/133] (853s left) gem_mmap_gtt (basic-write-gtt)
[166.413044] Subtest basic-write-gtt: SKIP (0.000s)
[166.483773] [041/133] (853s left) gem_userptr_blits (set-cache-level)
[166.551623] Starting subtest: set-cache-level
[166.555967] Subtest set-cache-level: SKIP (0.000s)
[166.709265] [042/133] (853s left) kms_psr (psr-primary-render)
[166.820948] Starting subtest: psr-primary-render
[166.823279] Starting dynamic subtest: eDP-1
[168.520993] Dynamic subtest eDP-1: SUCCESS (1.700s)
[168.523481] Subtest psr-primary-render: SUCCESS (1.701s)
[169.416760] [043/133] (850s left) gem_create (create-ext-placement-sanity-check)
[169.595863] Starting subtest: create-ext-placement-sanity-check
[169.601669] Subtest create-ext-placement-sanity-check: SUCCESS (0.006s)
[169.720253] [044/133] (850s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[169.831248] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[169.839243] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[169.980160] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[170.066621] Starting subtest: u-lateslice
[170.068824] Starting dynamic subtest: rcs0
[170.077398] Dynamic subtest rcs0: SUCCESS (0.021s)
[170.087381] Starting dynamic subtest: bcs0
[170.094455] Dynamic subtest bcs0: SUCCESS (0.017s)
[170.103356] Starting dynamic subtest: vcs0
[170.112463] Dynamic subtest vcs0: SUCCESS (0.018s)
[170.120082] Starting dynamic subtest: vcs1
[170.130662] Dynamic subtest vcs1: SUCCESS (0.018s)
[170.138342] Starting dynamic subtest: vecs0
[170.148661] Dynamic subtest vecs0: SUCCESS (0.017s)
[170.156173] Starting dynamic subtest: ccs0
[170.165736] Dynamic subtest ccs0: SUCCESS (0.016s)
[170.167925] Subtest u-lateslice: SUCCESS (0.110s)
[172.030505] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[172.117036] Starting subtest: dpms-off-confusion-interruptible
[172.119295] Starting dynamic subtest: A-eDP1
[180.795804] Dynamic subtest A-eDP1: SUCCESS (8.677s)
[180.809721] Starting dynamic subtest: B-eDP1
[189.429662] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[189.439123] Starting dynamic subtest: C-eDP1
[198.043100] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[198.051128] Starting dynamic subtest: D-eDP1
[206.676282] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[206.681107] Subtest dpms-off-confusion-interruptible: SUCCESS (34.563s)
[207.869454] [047/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[207.981930] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[214.710925] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.730s)
[214.868849] [048/133] (805s left) kms_plane (plane-position-hole)
[214.957501] Starting subtest: plane-position-hole
[215.471914] Starting dynamic subtest: pipe-A-plane-1
[216.780874] Dynamic subtest pipe-A-plane-1: SUCCESS (1.309s)
[216.789708] Starting dynamic subtest: pipe-A-plane-2
[218.068363] Dynamic subtest pipe-A-plane-2: SUCCESS (1.288s)
[218.076643] Starting dynamic subtest: pipe-A-plane-3
[219.294990] Dynamic subtest pipe-A-plane-3: SUCCESS (1.225s)
[219.306396] Starting dynamic subtest: pipe-A-plane-4
[220.527328] Dynamic subtest pipe-A-plane-4: SUCCESS (1.231s)
[220.535962] Starting dynamic subtest: pipe-A-plane-5
[220.552567] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[221.688782] Starting dynamic subtest: pipe-B-plane-1
[222.903458] Dynamic subtest pipe-B-plane-1: SUCCESS (1.219s)
[222.912990] Starting dynamic subtest: pipe-B-plane-2
[224.147793] Dynamic subtest pipe-B-plane-2: SUCCESS (1.245s)
[224.156073] Starting dynamic subtest: pipe-B-plane-3
[225.364839] Dynamic subtest pipe-B-plane-3: SUCCESS (1.215s)
[225.374387] Starting dynamic subtest: pipe-B-plane-4
[226.599673] Dynamic subtest pipe-B-plane-4: SUCCESS (1.235s)
[226.609253] Starting dynamic subtest: pipe-B-plane-5
[226.627118] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[226.629457] Subtest plane-position-hole: SUCCESS (11.670s)
[227.413695] [049/133] (792s left) kms_draw_crc (draw-method-mmap-cpu)
[227.527150] Starting subtest: draw-method-mmap-cpu
[227.529358] Starting dynamic subtest: xrgb8888-untiled
[227.748250] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[227.755973] Starting dynamic subtest: rgb565-untiled
[227.958426] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[227.966262] Starting dynamic subtest: xrgb2101010-untiled
[228.158654] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[228.166597] Starting dynamic subtest: xbgr16161616f-untiled
[228.358250] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[228.365717] Starting dynamic subtest: xrgb8888-xtiled
[228.480480] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[228.487985] Starting dynamic subtest: rgb565-xtiled
[228.602671] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[228.610650] Starting dynamic subtest: xrgb2101010-xtiled
[228.713814] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[228.721586] Starting dynamic subtest: xbgr16161616f-xtiled
[228.836381] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[228.844547] Starting dynamic subtest: xrgb8888-4tiled
[228.969959] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[228.977522] Starting dynamic subtest: rgb565-4tiled
[229.102685] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[229.110480] Starting dynamic subtest: xrgb2101010-4tiled
[229.224966] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[229.232518] Starting dynamic subtest: xbgr16161616f-4tiled
[229.358443] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[229.360338] Subtest draw-method-mmap-cpu: SUCCESS (1.834s)
[229.473885] [050/133] (790s left) gem_mmap_gtt (medium-copy-xy)
[229.539936] Subtest medium-copy-XY: SKIP (0.000s)
[229.602976] [051/133] (790s left) vgem_basic (bad-flag)
[229.644413] Starting subtest: bad-flag
[229.646471] Subtest bad-flag: SUCCESS (0.000s)
[229.713757] [052/133] (790s left) gem_ctx_persistence (engines-hostile-preempt)
[229.776456] Starting subtest: engines-hostile-preempt
[229.778334] Starting dynamic subtest: rcs0
[229.887715] Dynamic subtest rcs0: SUCCESS (0.110s)
[229.898623] Starting dynamic subtest: bcs0
[229.961867] Dynamic subtest bcs0: SUCCESS (0.072s)
[229.972417] Starting dynamic subtest: vcs0
[231.874879] Dynamic subtest vcs0: SUCCESS (1.909s)
[231.885483] Starting dynamic subtest: vcs1
[233.958370] Dynamic subtest vcs1: SUCCESS (2.081s)
[233.969068] Starting dynamic subtest: vecs0
[235.903969] Dynamic subtest vecs0: SUCCESS (1.943s)
[235.914609] Starting dynamic subtest: ccs0
[236.008461] Dynamic subtest ccs0: SUCCESS (0.103s)
[236.011322] Subtest engines-hostile-preempt: SUCCESS (6.231s)
[236.098174] [053/133] (784s left) kms_sequence (queue-idle)
[236.203208] Starting subtest: queue-idle
[236.205152] Starting dynamic subtest: pipe-A-eDP-1
[238.016763] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.814s)
[238.026266] Starting dynamic subtest: pipe-B-eDP-1
[240.476787] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.457s)
[240.485868] Starting dynamic subtest: pipe-C-eDP-1
[242.903020] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.425s)
[242.911525] Starting dynamic subtest: pipe-D-eDP-1
[245.326354] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.421s)
[245.328662] Subtest queue-idle: SUCCESS (9.125s)
[246.146536] [054/133] (774s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[246.249097] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[246.251392] Starting dynamic subtest: pipe-A-eDP-1
[246.323820] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[246.336683] Starting dynamic subtest: pipe-B-eDP-1
[247.415568] Dynamic subtest pipe-B-eDP-1: SKIP (1.087s)
[247.420197] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.167s)
[248.648867] [055/133] (771s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[248.759074] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[248.763606] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[248.884564] [056/133] (771s left) kms_atomic (atomic-plane-damage)
[248.987129] Starting subtest: atomic-plane-damage
[249.032219] Starting dynamic subtest: pipe-A-eDP-1
[249.558481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.526s)
[249.560741] Subtest atomic-plane-damage: SUCCESS (0.574s)
[250.371178] [057/133] (770s left) kms_big_fb (linear-16bpp-rotate-90)
[250.479474] Starting subtest: linear-16bpp-rotate-90
[250.501632] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[250.622796] [058/133] (770s left) perf (stress-open-close)
[250.749850] Starting subtest: stress-open-close
[250.752026] Starting dynamic subtest: 0-rcs0
[252.914069] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[252.921904] Starting dynamic subtest: 1-vcs0
[255.078773] Dynamic subtest 1-vcs0: SUCCESS (2.163s)
[255.080852] Subtest stress-open-close: SUCCESS (4.332s)
[255.124466] [059/133] (765s left) gem_workarounds (basic-read-fd)
[255.195268] Starting subtest: basic-read-fd
[255.212400] Subtest basic-read-fd: SUCCESS (0.017s)
[255.350404] [060/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[255.445849] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[256.457224] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.012s)
[256.602331] [061/133] (764s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[256.698400] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[256.701652] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[256.817841] [062/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[256.907830] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[256.911160] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[257.022930] [063/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[257.109142] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[257.112529] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[257.234926] [064/133] (763s left) kms_cursor_crc (cursor-offscreen-32x10)
[257.389080] Starting subtest: cursor-offscreen-32x10
[257.432634] Subtest cursor-offscreen-32x10: SKIP (0.039s)
[257.728598] [065/133] (763s left) kms_psr (psr2-primary-render)
[257.829517] Starting subtest: psr2-primary-render
[257.831480] Starting dynamic subtest: eDP-1
[259.543718] Dynamic subtest eDP-1: SUCCESS (1.715s)
[259.545985] Subtest psr2-primary-render: SUCCESS (1.716s)
[260.434087] [066/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[260.538147] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[260.542038] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[260.675171] [067/133] (760s left) gem_exec_schedule (noreorder-priority)
[260.872856] Starting subtest: noreorder-priority
[260.875347] Starting dynamic subtest: rcs0
[262.039853] Dynamic subtest rcs0: SUCCESS (1.166s)
[262.052391] Starting dynamic subtest: vcs0
[263.924378] Dynamic subtest vcs0: SUCCESS (1.881s)
[263.936503] Starting dynamic subtest: vcs1
[265.890529] Dynamic subtest vcs1: SUCCESS (1.964s)
[265.902124] Starting dynamic subtest: vecs0
[267.951998] Dynamic subtest vecs0: SUCCESS (2.060s)
[267.963936] Starting dynamic subtest: ccs0
[269.135090] Dynamic subtest ccs0: SUCCESS (1.182s)
[269.137702] Subtest noreorder-priority: SUCCESS (8.263s)
[269.332456] [068/133] (751s left) gem_softpin (allocator-evict)
[269.396152] Starting subtest: allocator-evict
[269.398545] Starting dynamic subtest: rcs0
[293.113430] Dynamic subtest rcs0: SUCCESS (23.717s)
[293.124279] Starting dynamic subtest: bcs0
[316.731058] Dynamic subtest bcs0: SUCCESS (23.616s)
[316.742160] Starting dynamic subtest: vcs0
[340.402979] Dynamic subtest vcs0: SUCCESS (23.669s)
[340.411884] Starting dynamic subtest: vcs1
[364.248446] Dynamic subtest vcs1: SUCCESS (23.842s)
[364.267060] Starting dynamic subtest: vecs0
[388.030706] Dynamic subtest vecs0: SUCCESS (23.779s)
[388.042670] Starting dynamic subtest: ccs0
[411.502085] Dynamic subtest ccs0: SUCCESS (23.469s)
[411.504995] Subtest allocator-evict: SUCCESS (142.102s)
[411.613421] [069/133] (609s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[411.773559] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[416.667040] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.896s)
[417.835862] [070/133] (603s left) gem_exec_reloc (basic-cpu-gtt-active)
[417.900102] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[417.985791] [071/133] (603s left) gem_ctx_shared (single-timeline)
[418.048493] Starting subtest: single-timeline
[418.068612] Subtest single-timeline: SUCCESS (0.015s)
[418.330041] [072/133] (602s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[418.414146] Starting subtest: etime-multi-wait-all-for-submit-submitted
[418.521379] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[418.619738] [073/133] (602s left) syncobj_timeline (etime-single-wait-all-submitted)
[418.683644] Starting subtest: etime-single-wait-all-submitted
[418.784036] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[418.879475] [074/133] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[419.274436] Subtest dp-hpd-storm: SKIP (0.000s)
[420.110659] [075/133] (601s left) kms_flip (2x-flip-vs-suspend)
[420.206269] Starting subtest: 2x-flip-vs-suspend
[420.214794] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[420.336325] [076/133] (601s left) kms_psr (fbc-psr2-sprite-plane-move)
[420.443371] Starting subtest: fbc-psr2-sprite-plane-move
[420.445575] Starting dynamic subtest: eDP-1
[420.449999] Dynamic subtest eDP-1: SKIP (0.000s)
[420.454343] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[420.527381] [077/133] (600s left) gem_exec_params (mmapped)
[420.586931] Starting subtest: mmapped
[420.589140] Subtest mmapped: SUCCESS (0.003s)
[420.744940] [078/133] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[420.837575] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[420.841625] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[420.932408] [079/133] (600s left) sw_sync (sync_merge_invalid)
[420.967016] Starting subtest: sync_merge_invalid
[420.997470] Subtest sync_merge_invalid: SUCCESS (0.029s)
[421.074883] [080/133] (600s left) perf_pmu (busy)
[421.112885] Starting subtest: busy
[421.114850] Starting dynamic subtest: rcs0
[421.722017] Dynamic subtest rcs0: SUCCESS (0.608s)
[421.733469] Starting dynamic subtest: bcs0
[422.291651] Dynamic subtest bcs0: SUCCESS (0.568s)
[422.303591] Starting dynamic subtest: vcs0
[423.893043] Dynamic subtest vcs0: SUCCESS (1.597s)
[423.904686] Starting dynamic subtest: vcs1
[425.875787] Dynamic subtest vcs1: SUCCESS (1.980s)
[425.887521] Starting dynamic subtest: vecs0
[427.924298] Dynamic subtest vecs0: SUCCESS (2.045s)
[427.935788] Starting dynamic subtest: ccs0
[428.496702] Dynamic subtest ccs0: SUCCESS (0.571s)
[428.499352] Subtest busy: SUCCESS (7.384s)
[428.618102] [081/133] (592s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[428.682074] Starting subtest: multi-wait-for-submit-submitted-signaled
[428.684264] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[428.805843] [082/133] (592s left) gem_mmap_wc (write-wc-read-gtt)
[428.871817] Subtest write-wc-read-gtt: SKIP (0.000s)
[428.939743] [083/133] (592s left) kms_hdmi_inject (inject-audio)
[429.294259] Starting subtest: inject-audio
[429.572987] Subtest inject-audio: SUCCESS (0.281s)
[430.207504] [084/133] (591s left) kms_flip (2x-blocking-wf_vblank)
[430.302687] Starting subtest: 2x-blocking-wf_vblank
[430.311456] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[430.405158] [085/133] (591s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[430.494296] Starting subtest: plane-all-transition-nonblocking-fencing
[430.496530] Starting dynamic subtest: pipe-A-eDP-1
[432.987930] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[433.301462] Starting dynamic subtest: pipe-B-eDP-1
[436.570507] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.278s)
[436.871917] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.378s)
[437.682344] [086/133] (584s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[437.810744] Starting subtest: flip-vs-cursor-crc-legacy
[438.470990] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.660s)
[439.274462] [087/133] (582s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[439.387924] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[439.392124] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[439.467425] [088/133] (582s left) gem_exec_params (invalid-ring2)
[439.523216] Starting subtest: invalid-ring2
[439.525587] Subtest invalid-ring2: SUCCESS (0.000s)
[439.654525] [089/133] (582s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[439.749782] Starting subtest: fbcpsr-slowdraw
[464.841824] Subtest fbcpsr-slowdraw: SUCCESS (25.094s)
[465.010691] [090/133] (556s left) kms_joiner (basic-force-ultra-joiner)
[465.113539] Starting subtest: basic-force-ultra-joiner
[465.117636] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[465.192446] [091/133] (556s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[465.285421] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[465.314650] Starting dynamic subtest: pipe-A-plane-0
[465.613180] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[465.621321] Starting dynamic subtest: pipe-A-plane-3
[465.848183] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[466.913937] Starting dynamic subtest: pipe-B-plane-0
[467.229533] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s)
[467.238775] Starting dynamic subtest: pipe-B-plane-3
[467.462636] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[467.769582] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.486s)
[468.578439] [092/133] (553s left) kms_vblank (query-forked-busy-hang)
[468.671274] Starting subtest: query-forked-busy-hang
[468.673613] Starting dynamic subtest: pipe-A-eDP-1
[494.682665] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.006s)
[494.696549] Starting dynamic subtest: pipe-D-eDP-1
[509.723642] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.037s)
[509.725779] Subtest query-forked-busy-hang: SUCCESS (41.049s)
[510.582220] [093/133] (511s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[510.689793] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[510.693780] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[510.813174] [094/133] (511s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[510.924694] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[511.526384] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.603s)
[511.733478] [095/133] (510s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[511.832173] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[511.834506] Starting dynamic subtest: pipe-A-default-mode
[514.562899] Dynamic subtest pipe-A-default-mode: SUCCESS (2.730s)
[514.565128] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.732s)
[515.378699] [096/133] (506s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[515.446905] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[515.552930] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[515.642109] [097/133] (506s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[515.751098] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[515.755557] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[515.882240] [098/133] (506s left) gem_exec_whisper (basic-fds-forked)
[515.949746] Starting subtest: basic-fds-forked
[540.122668] Subtest basic-fds-forked: SUCCESS (24.170s)
[540.315579] [099/133] (481s left) kms_addfb_basic (bad-pitch-999)
[540.385110] Starting subtest: bad-pitch-999
[540.387103] Subtest bad-pitch-999: SUCCESS (0.000s)
[540.559727] [100/133] (481s left) kms_prop_blob (basic)
[540.615873] Starting subtest: basic
[540.618067] Subtest basic: SUCCESS (0.000s)
[540.733361] [101/133] (481s left) syncobj_basic (bad-pad-fd-to-handle)
[540.794177] Starting subtest: bad-pad-fd-to-handle
[540.796077] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[540.926446] [102/133] (481s left) kms_cursor_crc (cursor-sliding-256x256)
[541.167993] Starting subtest: cursor-sliding-256x256
[541.170307] Starting dynamic subtest: pipe-A-eDP-1
[544.412792] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.242s)
[544.441643] Starting dynamic subtest: pipe-D-eDP-1
[548.411086] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.980s)
[548.413557] Subtest cursor-sliding-256x256: SUCCESS (7.245s)
[549.258788] [103/133] (473s left) gem_busy (busy)
[549.311844] Starting subtest: busy
[549.314294] Starting dynamic subtest: all-engines
[549.363726] Dynamic subtest all-engines: SUCCESS (0.051s)
[549.374935] Starting dynamic subtest: rcs0
[550.878478] Dynamic subtest rcs0: SUCCESS (1.513s)
[550.888018] Starting dynamic subtest: bcs0
[550.948264] Dynamic subtest bcs0: SUCCESS (0.066s)
[550.958024] Starting dynamic subtest: vcs0
[550.986325] Dynamic subtest vcs0: SUCCESS (0.038s)
[550.994719] Starting dynamic subtest: vcs1
[552.945380] Dynamic subtest vcs1: SUCCESS (1.931s)
[552.957286] Starting dynamic subtest: vecs0
[554.905090] Dynamic subtest vecs0: SUCCESS (1.984s)
[554.913843] Starting dynamic subtest: ccs0
[556.892814] Dynamic subtest ccs0: SUCCESS (1.984s)
[556.895055] Subtest busy: SUCCESS (7.577s)
[557.266725] [104/133] (465s left) i915_pm_rps (thresholds)
[557.325839] Starting subtest: thresholds
[557.330718] Subtest thresholds: SKIP (0.002s)
[557.448762] [105/133] (465s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[557.565512] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[557.567801] Starting dynamic subtest: pipe-A-eDP-1
[557.590491] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[557.607785] Starting dynamic subtest: pipe-B-eDP-1
[557.630187] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[557.647222] Starting dynamic subtest: pipe-C-eDP-1
[557.670084] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[557.686855] Starting dynamic subtest: pipe-D-eDP-1
[557.709647] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[557.714209] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[559.863826] [106/133] (462s left) gem_softpin (evict-snoop-interruptible)
[559.932742] Starting subtest: evict-snoop-interruptible
[559.937403] Subtest evict-snoop-interruptible: SKIP (0.000s)
[560.066403] [107/133] (462s left) gem_mmap_gtt (big-bo)
[560.127886] Subtest big-bo: SKIP (0.000s)
[560.192757] [108/133] (462s left) gem_partial_pwrite_pread (write-display)
[560.255070] Subtest write-display: SKIP (0.000s)
[560.336358] [109/133] (462s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[560.433881] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[560.436080] Starting dynamic subtest: pipe-A-eDP-1
[560.457739] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[560.467588] Starting dynamic subtest: pipe-B-eDP-1
[560.488224] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[560.496953] Starting dynamic subtest: pipe-C-eDP-1
[560.517744] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[560.527614] Starting dynamic subtest: pipe-D-eDP-1
[560.549061] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[560.553095] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[562.661033] [110/133] (460s left) kms_psr (fbc-pr-cursor-blt)
[562.759819] Starting subtest: fbc-pr-cursor-blt
[562.763797] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[562.839432] [111/133] (459s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[562.885483] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[562.887593] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[563.029023] [112/133] (459s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[563.089698] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[563.094442] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[563.285831] [113/133] (459s left) gem_mmap (basic)
[563.355481] Subtest basic: SKIP (0.000s)
[563.426182] [114/133] (459s left) gem_exec_gttfill (basic)
[563.495505] Starting subtest: basic
[565.995845] Subtest basic: SUCCESS (2.499s)
[566.201694] [115/133] (456s left) kms_addfb_basic (size-max)
[566.338065] Starting subtest: size-max
[566.340451] Subtest size-max: SUCCESS (0.000s)
[566.471017] [116/133] (456s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[566.576024] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[566.578262] Starting dynamic subtest: pipe-A-eDP-1
[566.599966] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[566.610666] Starting dynamic subtest: pipe-B-eDP-1
[566.631101] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[566.639574] Starting dynamic subtest: pipe-C-eDP-1
[566.661989] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[566.671077] Starting dynamic subtest: pipe-D-eDP-1
[566.692671] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[566.696954] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[568.860895] [117/133] (454s left) api_intel_bb (purge-bb)
[568.916027] Starting subtest: purge-bb
[568.920734] Subtest purge-bb: SUCCESS (0.005s)
[569.070986] [118/133] (454s left) kms_cursor_legacy (forked-move)
[569.197560] Starting subtest: forked-move
[569.199445] Starting dynamic subtest: pipe-A
[574.655866] Dynamic subtest pipe-A: SUCCESS (5.455s)
[574.667674] Starting dynamic subtest: pipe-B
[580.116601] Dynamic subtest pipe-B: SUCCESS (5.459s)
[580.128515] Starting dynamic subtest: pipe-C
[585.603620] Dynamic subtest pipe-C: SUCCESS (5.484s)
[585.616467] Starting dynamic subtest: pipe-D
[591.073512] Dynamic subtest pipe-D: SUCCESS (5.467s)
[591.085205] Starting dynamic subtest: all-pipes
[596.562898] Dynamic subtest all-pipes: SUCCESS (5.486s)
[596.565475] Subtest forked-move: SUCCESS (27.363s)
[596.719431] [119/133] (426s left) gen9_exec_parse (bb-chained)
[596.800274] Subtest bb-chained: SKIP (0.000s)
[596.902346] [120/133] (426s left) kms_concurrent (multi-plane-atomic-lowres)
[597.002141] Starting subtest: multi-plane-atomic-lowres
[597.004193] Starting dynamic subtest: pipe-A-eDP-1
[597.514564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s)
[597.516497] Subtest multi-plane-atomic-lowres: SUCCESS (0.510s)
[598.359979] [121/133] (424s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[598.438723] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[598.510298] [122/133] (424s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[598.582333] Starting subtest: multi-wait-available-unsubmitted-submitted
[598.584678] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[598.703817] [123/133] (424s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[598.809516] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[603.236764] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.431s)
[604.383743] [124/133] (418s left) kms_pm_dc (dc3co-vpb-simulation)
[605.483830] Starting subtest: dc3co-vpb-simulation
[614.797320] Subtest dc3co-vpb-simulation: SKIP (9.307s)
[614.925990] [125/133] (408s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[615.021791] Starting subtest: x-tiled-8bpp-rotate-90
[615.043527] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[615.215798] [126/133] (408s left) kms_plane_multiple (2x-tiling-none)
[615.320019] Starting subtest: 2x-tiling-none
[615.324059] Subtest 2x-tiling-none: SKIP (0.000s)
[615.420062] [127/133] (408s left) gem_exec_balancer (bonded-false-hang)
[615.680957] Starting subtest: bonded-false-hang
[615.685580] Subtest bonded-false-hang: SKIP (0.000s)
[615.820227] [128/133] (407s left) i915_drm_fdinfo (idle)
[615.862065] Starting subtest: idle
[615.863878] Starting dynamic subtest: rcs0
[616.465239] Dynamic subtest rcs0: SUCCESS (0.604s)
[616.475074] Starting dynamic subtest: bcs0
[616.972471] Dynamic subtest bcs0: SUCCESS (0.503s)
[616.981757] Starting dynamic subtest: vcs0
[617.477919] Dynamic subtest vcs0: SUCCESS (0.503s)
[617.487600] Starting dynamic subtest: vcs1
[617.984907] Dynamic subtest vcs1: SUCCESS (0.504s)
[617.997061] Starting dynamic subtest: vecs0
[618.490556] Dynamic subtest vecs0: SUCCESS (0.503s)
[618.501827] Starting dynamic subtest: ccs0
[618.996471] Dynamic subtest ccs0: SUCCESS (0.503s)
[618.999261] Subtest idle: SUCCESS (3.136s)
[619.086095] [129/133] (404s left) kms_getfb (getfb2-handle-closed)
[619.184942] Starting subtest: getfb2-handle-closed
[619.187251] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[619.303225] [130/133] (404s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[619.359638] Starting subtest: invalid-bsd1-flag-on-vebox
[619.361604] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[619.488519] [131/133] (404s left) kms_psr (fbc-pr-suspend)
[619.582083] Starting subtest: fbc-pr-suspend
[619.586264] Subtest fbc-pr-suspend: SKIP (0.000s)
[619.680867] [132/133] (404s left) gem_softpin (overlap)
[619.750802] Starting subtest: overlap
[620.602219] Subtest overlap: SUCCESS (0.851s)
[620.765590] [133/133] (402s left) gem_madvise (dontneed-before-mmap)
[620.805293] Starting subtest: dontneed-before-mmap
[620.840793] Subtest dontneed-before-mmap: SUCCESS (0.037s)
[620.961802] 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.