[58.041129] Initializing watchdogs
[58.041175]   /dev/watchdog0
[58.055421] [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.062579] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.065086] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.068480] [001/133] (960s left) perf_pmu (busy-start)
[58.129721] Starting subtest: busy-start
[58.132112] Starting dynamic subtest: rcs0
[60.689976] Dynamic subtest rcs0: SUCCESS (2.550s)
[60.699873] Starting dynamic subtest: bcs0
[63.240931] Dynamic subtest bcs0: SUCCESS (2.543s)
[63.250710] Starting dynamic subtest: vcs0
[66.901397] Dynamic subtest vcs0: SUCCESS (3.651s)
[66.911026] Starting dynamic subtest: vcs1
[70.933879] Dynamic subtest vcs1: SUCCESS (4.025s)
[70.943593] Starting dynamic subtest: vecs0
[74.902056] Dynamic subtest vecs0: SUCCESS (3.964s)
[74.912854] Starting dynamic subtest: ccs0
[77.450329] Dynamic subtest ccs0: SUCCESS (2.548s)
[77.452888] Subtest busy-start: SUCCESS (19.288s)
[77.587977] [002/133] (941s left) gem_exec_flush (basic-wb-rw-before-default)
[77.653339] Starting subtest: basic-wb-rw-before-default
[83.108032] Subtest basic-wb-rw-before-default: SUCCESS (5.453s)
[83.312991] [003/133] (935s left) kms_lease (lessee-list)
[83.412111] Starting subtest: lessee-list
[83.414514] Starting dynamic subtest: pipe-A-eDP-1
[83.416927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[83.425999] Starting dynamic subtest: pipe-B-eDP-1
[83.428235] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[83.435301] Starting dynamic subtest: pipe-C-eDP-1
[83.437546] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[83.445889] Starting dynamic subtest: pipe-D-eDP-1
[83.448065] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[83.450191] Subtest lessee-list: SUCCESS (0.007s)
[83.524538] [004/133] (935s left) i915_drm_fdinfo (virtual-busy-hang-all)
[83.565348] Starting subtest: virtual-busy-hang-all
[83.569892] Subtest virtual-busy-hang-all: SKIP (0.000s)
[83.632195] [005/133] (935s left) kms_atomic_interruptible (legacy-setmode)
[83.731580] Starting subtest: legacy-setmode
[83.733981] Starting dynamic subtest: pipe-A-eDP-1
[90.596857] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.863s)
[90.599067] Subtest legacy-setmode: SUCCESS (6.864s)
[91.405818] [006/133] (927s left) kms_color (ctm-max)
[91.507715] Starting subtest: ctm-max
[91.510074] Starting dynamic subtest: pipe-A-eDP-1
[92.202262] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[92.210787] Starting dynamic subtest: pipe-B-eDP-1
[93.595659] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[93.604296] Starting dynamic subtest: pipe-C-eDP-1
[94.987044] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[94.995147] Starting dynamic subtest: pipe-D-eDP-1
[96.284782] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[96.287162] Subtest ctm-max: SUCCESS (4.778s)
[97.115134] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[97.215846] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[101.721058] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.506s)
[102.850300] [008/133] (915s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[102.961110] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[102.965083] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[103.060389] [009/133] (915s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[103.153844] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[103.160922] Starting dynamic subtest: pipe-A
[103.198369] Dynamic subtest pipe-A: SKIP (0.039s)
[103.205659] Starting dynamic subtest: pipe-B
[103.247479] Dynamic subtest pipe-B: SKIP (0.049s)
[103.254441] Starting dynamic subtest: pipe-C
[103.275992] Dynamic subtest pipe-C: SKIP (0.029s)
[103.282864] Starting dynamic subtest: pipe-D
[103.306220] Dynamic subtest pipe-D: SKIP (0.029s)
[103.310176] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.148s)
[103.423809] [010/133] (915s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[103.535874] Starting subtest: y-tiled-64bpp-rotate-180
[103.540419] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[103.658236] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[103.757675] Starting subtest: primary-x-tiled-reflect-x-180
[110.737448] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.981s)
[112.009510] [012/133] (906s left) kms_flip (2x-flip-vs-expired-vblank)
[112.118416] Starting subtest: 2x-flip-vs-expired-vblank
[112.126742] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[112.271212] [013/133] (906s left) api_intel_allocator (fork-simple-stress)
[112.330854] Starting subtest: fork-simple-stress
[117.732230] Subtest fork-simple-stress: SUCCESS (5.398s)
[117.875899] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[117.977453] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[124.538567] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.564s)
[124.673831] [015/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[124.774646] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[124.778827] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[124.894903] [016/133] (894s left) gem_mmap (bad-size)
[124.964585] Subtest bad-size: SKIP (0.000s)
[125.021533] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[125.075117] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[125.079778] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[125.266936] [018/133] (893s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[125.372051] Starting subtest: psr-2p-primscrn-cur-indfb-move
[125.376713] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[125.484423] [019/133] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[125.586239] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[132.141201] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.556s)
[132.265466] [020/133] (886s left) syncobj_timeline (wait-all-snapshot)
[132.321086] Starting subtest: wait-all-snapshot
[132.401447] Subtest wait-all-snapshot: SUCCESS (0.081s)
[132.484531] [021/133] (886s left) gem_partial_pwrite_pread (reads)
[132.555508] Subtest reads: SKIP (0.000s)
[132.637968] [022/133] (886s left) syncobj_basic (create-signaled)
[132.700170] Starting subtest: create-signaled
[132.702577] Subtest create-signaled: SUCCESS (0.000s)
[132.840062] [023/133] (886s left) kms_chamelium_frames (dp-crc-multiple)
[133.224749] Subtest dp-crc-multiple: SKIP (0.000s)
[134.051456] [024/133] (885s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[134.179549] Starting subtest: cursorA-vs-flipA-varying-size
[145.334711] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.156s)
[146.209115] [025/133] (873s left) gem_ctx_persistence (hang)
[146.272821] Starting subtest: hang
[146.277487] Subtest hang: SKIP (0.000s)
[146.383553] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[146.483190] Starting subtest: pr-primary-page-flip
[146.487567] Subtest pr-primary-page-flip: SKIP (0.000s)
[146.570943] [027/133] (872s left) gem_lmem_swapping (heavy-random)
[146.612272] Subtest heavy-random: SKIP (0.000s)
[146.649369] [028/133] (872s left) kms_addfb_basic (master-rmfb)
[146.710699] Starting subtest: master-rmfb
[146.712959] Subtest master-rmfb: SUCCESS (0.001s)
[146.879516] [029/133] (872s left) kms_addfb_basic (invalid-get-prop-any)
[146.946051] Starting subtest: invalid-get-prop-any
[146.948360] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[147.109867] [030/133] (872s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[147.196056] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[147.197947] Starting dynamic subtest: pipe-A-eDP-1
[147.219052] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.228511] Starting dynamic subtest: pipe-B-eDP-1
[147.247571] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.254717] Starting dynamic subtest: pipe-C-eDP-1
[147.273983] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.282918] Starting dynamic subtest: pipe-D-eDP-1
[147.303143] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.306522] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[149.388272] [031/133] (870s left) gem_exec_basic (basic)
[149.456124] Starting subtest: basic
[149.458525] Starting dynamic subtest: rcs0-smem
[149.460844] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[149.470858] Starting dynamic subtest: bcs0-smem
[149.473085] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[149.480291] Starting dynamic subtest: vcs0-smem
[149.482443] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[149.489498] Starting dynamic subtest: vcs1-smem
[149.491714] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[149.499082] Starting dynamic subtest: vecs0-smem
[149.501218] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[149.508468] Starting dynamic subtest: ccs0-smem
[149.510692] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[149.512876] Subtest basic: SUCCESS (0.012s)
[150.986952] [032/133] (868s left) gem_mmap_offset (oob-read)
[151.044078] Starting subtest: oob-read
[151.046318] Subtest oob-read: SUCCESS (0.000s)
[151.158023] [033/133] (868s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[151.251993] Starting subtest: bad-pixel-format-yf-tiled-ccs
[151.254129] Starting dynamic subtest: pipe-A-eDP-1
[151.276162] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.285989] Starting dynamic subtest: pipe-B-eDP-1
[151.307134] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.314732] Starting dynamic subtest: pipe-C-eDP-1
[151.336971] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.346271] Starting dynamic subtest: pipe-D-eDP-1
[151.367285] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.371085] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[153.541656] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[153.732691] Starting subtest: cursor-random-64x21
[153.777367] Subtest cursor-random-64x21: SKIP (0.039s)
[154.023064] [035/133] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[154.128255] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[154.132303] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[154.250117] [036/133] (865s left) kms_plane_alpha_blend (constant-alpha-max)
[154.334326] Starting subtest: constant-alpha-max
[154.665287] Starting dynamic subtest: pipe-A-eDP-1
[155.625485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.959s)
[155.633616] Starting dynamic subtest: pipe-D-eDP-1
[157.247234] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.620s)
[157.249612] Subtest constant-alpha-max: SUCCESS (2.914s)
[158.110194] [037/133] (861s left) gem_exec_fence (keep-in-fence)
[158.287272] Starting subtest: keep-in-fence
[158.289143] Starting dynamic subtest: rcs0
[158.350958] Dynamic subtest rcs0: SUCCESS (0.066s)
[158.361385] Starting dynamic subtest: bcs0
[158.403173] Dynamic subtest bcs0: SUCCESS (0.051s)
[158.413787] Starting dynamic subtest: vcs0
[159.896057] Dynamic subtest vcs0: SUCCESS (1.489s)
[159.906723] Starting dynamic subtest: vcs1
[161.879600] Dynamic subtest vcs1: SUCCESS (1.981s)
[161.888909] Starting dynamic subtest: vecs0
[163.927903] Dynamic subtest vecs0: SUCCESS (2.046s)
[163.940016] Starting dynamic subtest: ccs0
[164.172438] Dynamic subtest ccs0: SUCCESS (0.244s)
[164.175115] Subtest keep-in-fence: SUCCESS (5.889s)
[166.023470] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[166.026970] [038/133] (853s left) i915_pm_rps (min-max-config-idle)
[166.100512] Starting subtest: min-max-config-idle
[166.105213] Subtest min-max-config-idle: SKIP (0.001s)
[166.230947] [039/133] (853s left) dumb_buffer (map-invalid-size)
[166.292401] Starting subtest: map-invalid-size
[166.294330] Subtest map-invalid-size: SUCCESS (0.000s)
[166.424084] [040/133] (853s left) gem_mmap_gtt (basic-write-gtt)
[166.505229] Subtest basic-write-gtt: SKIP (0.000s)
[166.571382] [041/133] (853s left) gem_userptr_blits (set-cache-level)
[166.635878] Starting subtest: set-cache-level
[166.639971] Subtest set-cache-level: SKIP (0.000s)
[166.801988] [042/133] (853s left) kms_psr (psr-primary-render)
[166.904836] Starting subtest: psr-primary-render
[166.907106] Starting dynamic subtest: eDP-1
[168.610547] Dynamic subtest eDP-1: SUCCESS (1.704s)
[168.612658] Subtest psr-primary-render: SUCCESS (1.705s)
[169.474605] [043/133] (850s left) gem_create (create-ext-placement-sanity-check)
[169.647088] Starting subtest: create-ext-placement-sanity-check
[169.649933] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[169.775064] [044/133] (850s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[169.872897] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[169.881654] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[170.006596] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[170.080284] Starting subtest: u-lateslice
[170.082107] Starting dynamic subtest: rcs0
[170.094024] Dynamic subtest rcs0: SUCCESS (0.021s)
[170.103908] Starting dynamic subtest: bcs0
[170.112483] Dynamic subtest bcs0: SUCCESS (0.018s)
[170.120511] Starting dynamic subtest: vcs0
[170.131497] Dynamic subtest vcs0: SUCCESS (0.019s)
[170.139489] Starting dynamic subtest: vcs1
[170.149261] Dynamic subtest vcs1: SUCCESS (0.017s)
[170.156987] Starting dynamic subtest: vecs0
[170.166495] Dynamic subtest vecs0: SUCCESS (0.017s)
[170.174160] Starting dynamic subtest: ccs0
[170.183861] Dynamic subtest ccs0: SUCCESS (0.017s)
[170.186060] Subtest u-lateslice: SUCCESS (0.111s)
[172.041426] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[172.147464] Starting subtest: dpms-off-confusion-interruptible
[172.149826] Starting dynamic subtest: A-eDP1
[180.775841] Dynamic subtest A-eDP1: SUCCESS (8.627s)
[180.786593] Starting dynamic subtest: B-eDP1
[189.401410] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[189.412089] Starting dynamic subtest: C-eDP1
[198.021498] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[198.031225] Starting dynamic subtest: D-eDP1
[206.658235] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[206.663455] Subtest dpms-off-confusion-interruptible: SUCCESS (34.515s)
[207.836629] [047/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[207.935290] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[214.701527] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.767s)
[214.889565] [048/133] (805s left) kms_plane (plane-position-hole)
[214.983901] Starting subtest: plane-position-hole
[215.487236] Starting dynamic subtest: pipe-A-plane-1
[216.779849] Dynamic subtest pipe-A-plane-1: SUCCESS (1.293s)
[216.788732] Starting dynamic subtest: pipe-A-plane-2
[218.051737] Dynamic subtest pipe-A-plane-2: SUCCESS (1.272s)
[218.060917] Starting dynamic subtest: pipe-A-plane-3
[219.290241] Dynamic subtest pipe-A-plane-3: SUCCESS (1.238s)
[219.299720] Starting dynamic subtest: pipe-A-plane-4
[220.524893] Dynamic subtest pipe-A-plane-4: SUCCESS (1.232s)
[220.533216] Starting dynamic subtest: pipe-A-plane-5
[220.550335] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[221.674886] Starting dynamic subtest: pipe-B-plane-1
[222.894244] Dynamic subtest pipe-B-plane-1: SUCCESS (1.225s)
[222.902913] Starting dynamic subtest: pipe-B-plane-2
[224.129819] Dynamic subtest pipe-B-plane-2: SUCCESS (1.234s)
[224.140310] Starting dynamic subtest: pipe-B-plane-3
[225.354124] Dynamic subtest pipe-B-plane-3: SUCCESS (1.222s)
[225.366661] Starting dynamic subtest: pipe-B-plane-4
[226.601345] Dynamic subtest pipe-B-plane-4: SUCCESS (1.248s)
[226.610068] Starting dynamic subtest: pipe-B-plane-5
[226.626340] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[226.628563] Subtest plane-position-hole: SUCCESS (11.642s)
[227.403394] [049/133] (792s left) kms_draw_crc (draw-method-mmap-cpu)
[227.497221] Starting subtest: draw-method-mmap-cpu
[227.499299] Starting dynamic subtest: xrgb8888-untiled
[227.728359] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[227.736063] Starting dynamic subtest: rgb565-untiled
[227.927583] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[227.935555] Starting dynamic subtest: xrgb2101010-untiled
[228.127745] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[228.135796] Starting dynamic subtest: xbgr16161616f-untiled
[228.349603] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[228.357352] Starting dynamic subtest: xrgb8888-xtiled
[228.482952] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[228.491363] Starting dynamic subtest: rgb565-xtiled
[228.604804] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[228.613182] Starting dynamic subtest: xrgb2101010-xtiled
[228.715905] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[228.723609] Starting dynamic subtest: xbgr16161616f-xtiled
[228.838480] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[228.846356] Starting dynamic subtest: xrgb8888-4tiled
[228.972422] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[228.987274] Starting dynamic subtest: rgb565-4tiled
[229.116284] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s)
[229.126046] Starting dynamic subtest: xrgb2101010-4tiled
[229.249612] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[229.257806] Starting dynamic subtest: xbgr16161616f-4tiled
[229.382666] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[229.384586] Subtest draw-method-mmap-cpu: SUCCESS (1.889s)
[229.512527] [050/133] (790s left) gem_mmap_gtt (medium-copy-xy)
[229.575705] Subtest medium-copy-XY: SKIP (0.000s)
[229.644957] [051/133] (790s left) vgem_basic (bad-flag)
[229.690616] Starting subtest: bad-flag
[229.692658] Subtest bad-flag: SUCCESS (0.000s)
[229.760170] [052/133] (790s left) gem_ctx_persistence (engines-hostile-preempt)
[229.836854] Starting subtest: engines-hostile-preempt
[229.838925] Starting dynamic subtest: rcs0
[229.913168] Dynamic subtest rcs0: SUCCESS (0.076s)
[229.922774] Starting dynamic subtest: bcs0
[230.017670] Dynamic subtest bcs0: SUCCESS (0.103s)
[230.029787] Starting dynamic subtest: vcs0
[231.920332] Dynamic subtest vcs0: SUCCESS (1.898s)
[231.930709] Starting dynamic subtest: vcs1
[233.860298] Dynamic subtest vcs1: SUCCESS (1.937s)
[233.870683] Starting dynamic subtest: vecs0
[235.958417] Dynamic subtest vecs0: SUCCESS (2.095s)
[235.968667] Starting dynamic subtest: ccs0
[236.046620] Dynamic subtest ccs0: SUCCESS (0.086s)
[236.049399] Subtest engines-hostile-preempt: SUCCESS (6.210s)
[236.143111] [053/133] (784s left) kms_sequence (queue-idle)
[236.247810] Starting subtest: queue-idle
[236.249995] Starting dynamic subtest: pipe-A-eDP-1
[238.064291] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[238.073385] Starting dynamic subtest: pipe-B-eDP-1
[240.584593] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.518s)
[240.595686] Starting dynamic subtest: pipe-C-eDP-1
[243.089777] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.503s)
[243.097991] Starting dynamic subtest: pipe-D-eDP-1
[245.521628] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[245.523758] Subtest queue-idle: SUCCESS (9.274s)
[246.335376] [054/133] (774s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[246.432746] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[246.435083] Starting dynamic subtest: pipe-A-eDP-1
[246.505909] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[246.515732] Starting dynamic subtest: pipe-B-eDP-1
[247.602018] Dynamic subtest pipe-B-eDP-1: SKIP (1.094s)
[247.606528] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.173s)
[248.794770] [055/133] (771s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[248.898706] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[248.903268] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[249.033063] [056/133] (771s left) kms_atomic (atomic-plane-damage)
[249.131214] Starting subtest: atomic-plane-damage
[249.180549] Starting dynamic subtest: pipe-A-eDP-1
[249.702286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.521s)
[249.704271] Subtest atomic-plane-damage: SUCCESS (0.570s)
[250.525769] [057/133] (770s left) kms_big_fb (linear-16bpp-rotate-90)
[250.623582] Starting subtest: linear-16bpp-rotate-90
[250.644956] Subtest linear-16bpp-rotate-90: SKIP (0.021s)
[250.817636] [058/133] (769s left) perf (stress-open-close)
[250.949097] Starting subtest: stress-open-close
[250.950941] Starting dynamic subtest: 0-rcs0
[253.110525] Dynamic subtest 0-rcs0: SUCCESS (2.163s)
[253.120512] Starting dynamic subtest: 1-vcs0
[255.272778] Dynamic subtest 1-vcs0: SUCCESS (2.161s)
[255.275073] Subtest stress-open-close: SUCCESS (4.327s)
[255.317432] [059/133] (765s left) gem_workarounds (basic-read-fd)
[255.384572] Starting subtest: basic-read-fd
[255.399493] Subtest basic-read-fd: SUCCESS (0.015s)
[255.549382] [060/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[255.654892] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[256.656586] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.001s)
[256.803592] [061/133] (764s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[256.901893] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[256.905430] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[257.021387] [062/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[257.137591] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[257.141045] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[257.258099] [063/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[257.352079] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[257.355401] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[257.457903] [064/133] (763s left) kms_cursor_crc (cursor-offscreen-32x10)
[257.616491] Starting subtest: cursor-offscreen-32x10
[257.659359] Subtest cursor-offscreen-32x10: SKIP (0.038s)
[257.986262] [065/133] (763s left) kms_psr (psr2-primary-render)
[258.084739] Starting subtest: psr2-primary-render
[258.086771] Starting dynamic subtest: eDP-1
[259.813800] Dynamic subtest eDP-1: SUCCESS (1.729s)
[259.816114] Subtest psr2-primary-render: SUCCESS (1.731s)
[260.690517] [066/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[260.799705] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[260.804429] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[260.910777] [067/133] (760s left) gem_exec_schedule (noreorder-priority)
[261.095034] Starting subtest: noreorder-priority
[261.097804] Starting dynamic subtest: rcs0
[262.255986] Dynamic subtest rcs0: SUCCESS (1.161s)
[262.268864] Starting dynamic subtest: vcs0
[263.919522] Dynamic subtest vcs0: SUCCESS (1.660s)
[263.931203] Starting dynamic subtest: vcs1
[265.924457] Dynamic subtest vcs1: SUCCESS (2.002s)
[265.935616] Starting dynamic subtest: vecs0
[267.957584] Dynamic subtest vecs0: SUCCESS (2.030s)
[267.969103] Starting dynamic subtest: ccs0
[269.122968] Dynamic subtest ccs0: SUCCESS (1.164s)
[269.125778] Subtest noreorder-priority: SUCCESS (8.030s)
[269.325376] [068/133] (751s left) gem_softpin (allocator-evict)
[269.396763] Starting subtest: allocator-evict
[269.399121] Starting dynamic subtest: rcs0
[293.124395] Dynamic subtest rcs0: SUCCESS (23.727s)
[293.133490] Starting dynamic subtest: bcs0
[316.800646] Dynamic subtest bcs0: SUCCESS (23.674s)
[316.811564] Starting dynamic subtest: vcs0
[340.516818] Dynamic subtest vcs0: SUCCESS (23.714s)
[340.526132] Starting dynamic subtest: vcs1
[364.126391] Dynamic subtest vcs1: SUCCESS (23.608s)
[364.138111] Starting dynamic subtest: vecs0
[387.658830] Dynamic subtest vecs0: SUCCESS (23.530s)
[387.670743] Starting dynamic subtest: ccs0
[411.121614] Dynamic subtest ccs0: SUCCESS (23.460s)
[411.124487] Subtest allocator-evict: SUCCESS (141.720s)
[411.214556] [069/133] (609s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[411.373372] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[416.263909] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.892s)
[417.470215] [070/133] (603s left) gem_exec_reloc (basic-cpu-gtt-active)
[417.537810] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[417.617739] [071/133] (603s left) gem_ctx_shared (single-timeline)
[417.681663] Starting subtest: single-timeline
[417.702432] Subtest single-timeline: SUCCESS (0.014s)
[417.952198] [072/133] (603s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[418.017450] Starting subtest: etime-multi-wait-all-for-submit-submitted
[418.122770] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[418.209473] [073/133] (603s left) syncobj_timeline (etime-single-wait-all-submitted)
[418.268777] Starting subtest: etime-single-wait-all-submitted
[418.371085] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[418.468087] [074/133] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[418.849759] Subtest dp-hpd-storm: SKIP (0.000s)
[419.662076] [075/133] (601s left) kms_flip (2x-flip-vs-suspend)
[419.759261] Starting subtest: 2x-flip-vs-suspend
[419.768279] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[419.893060] [076/133] (601s left) kms_psr (fbc-psr2-sprite-plane-move)
[419.975206] Starting subtest: fbc-psr2-sprite-plane-move
[419.977328] Starting dynamic subtest: eDP-1
[419.981584] Dynamic subtest eDP-1: SKIP (0.000s)
[419.985797] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[420.061118] [077/133] (601s left) gem_exec_params (mmapped)
[420.119972] Starting subtest: mmapped
[420.125745] Subtest mmapped: SUCCESS (0.005s)
[420.294088] [078/133] (601s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[420.391268] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[420.395373] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[420.517241] [079/133] (601s left) sw_sync (sync_merge_invalid)
[420.557158] Starting subtest: sync_merge_invalid
[420.577357] Subtest sync_merge_invalid: SUCCESS (0.021s)
[420.659622] [080/133] (600s left) perf_pmu (busy)
[420.694420] Starting subtest: busy
[420.696246] Starting dynamic subtest: rcs0
[421.299724] Dynamic subtest rcs0: SUCCESS (0.606s)
[421.310810] Starting dynamic subtest: bcs0
[421.867231] Dynamic subtest bcs0: SUCCESS (0.566s)
[421.878710] Starting dynamic subtest: vcs0
[423.894453] Dynamic subtest vcs0: SUCCESS (2.023s)
[423.906224] Starting dynamic subtest: vcs1
[425.942539] Dynamic subtest vcs1: SUCCESS (2.045s)
[425.953987] Starting dynamic subtest: vecs0
[427.926751] Dynamic subtest vecs0: SUCCESS (1.981s)
[427.941381] Starting dynamic subtest: ccs0
[428.505208] Dynamic subtest ccs0: SUCCESS (0.577s)
[428.508192] Subtest busy: SUCCESS (7.813s)
[428.618774] [081/133] (593s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[428.669977] Starting subtest: multi-wait-for-submit-submitted-signaled
[428.672314] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[428.809166] [082/133] (592s left) gem_mmap_wc (write-wc-read-gtt)
[428.859770] Subtest write-wc-read-gtt: SKIP (0.000s)
[428.930654] [083/133] (592s left) kms_hdmi_inject (inject-audio)
[429.287475] Starting subtest: inject-audio
[429.568718] Subtest inject-audio: SUCCESS (0.283s)
[430.162356] [084/133] (591s left) kms_flip (2x-blocking-wf_vblank)
[430.259309] Starting subtest: 2x-blocking-wf_vblank
[430.270493] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[430.360864] [085/133] (591s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[430.459060] Starting subtest: plane-all-transition-nonblocking-fencing
[430.461289] Starting dynamic subtest: pipe-A-eDP-1
[432.957560] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[433.261135] Starting dynamic subtest: pipe-B-eDP-1
[436.515519] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.262s)
[436.819762] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.359s)
[437.638346] [086/133] (584s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[437.763916] Starting subtest: flip-vs-cursor-crc-legacy
[438.475351] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.711s)
[439.320555] [087/133] (582s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[439.425494] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[439.429815] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[439.519025] [088/133] (582s left) gem_exec_params (invalid-ring2)
[439.576413] Starting subtest: invalid-ring2
[439.578612] Subtest invalid-ring2: SUCCESS (0.000s)
[439.700555] [089/133] (582s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[439.805759] Starting subtest: fbcpsr-slowdraw
[464.898153] Subtest fbcpsr-slowdraw: SUCCESS (25.094s)
[465.063965] [090/133] (556s left) kms_joiner (basic-force-ultra-joiner)
[465.189056] Starting subtest: basic-force-ultra-joiner
[465.193197] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[465.269473] [091/133] (556s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[465.382160] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[465.407698] Starting dynamic subtest: pipe-A-plane-0
[465.695940] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[465.704599] Starting dynamic subtest: pipe-A-plane-3
[465.929793] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[467.076802] Starting dynamic subtest: pipe-B-plane-0
[467.380527] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[467.389707] Starting dynamic subtest: pipe-B-plane-3
[467.613952] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[467.937937] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.555s)
[468.837581] [092/133] (553s left) kms_vblank (query-forked-busy-hang)
[468.936079] Starting subtest: query-forked-busy-hang
[468.938222] Starting dynamic subtest: pipe-A-eDP-1
[495.637981] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.700s)
[495.652352] Starting dynamic subtest: pipe-D-eDP-1
[520.664173] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[520.666521] Subtest query-forked-busy-hang: SUCCESS (51.727s)
[521.530089] [093/133] (500s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[521.635038] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[521.639436] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[521.754987] [094/133] (500s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[521.854894] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[522.434804] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.581s)
[522.627054] [095/133] (499s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[522.722372] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[522.724687] Starting dynamic subtest: pipe-A-default-mode
[525.393686] Dynamic subtest pipe-A-default-mode: SUCCESS (2.672s)
[525.396274] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.673s)
[526.255669] [096/133] (496s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[526.330834] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[526.436956] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[526.522080] [097/133] (495s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[526.645698] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[526.650160] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[526.777647] [098/133] (495s left) gem_exec_whisper (basic-fds-forked)
[526.846141] Starting subtest: basic-fds-forked
[549.917155] Subtest basic-fds-forked: SUCCESS (23.067s)
[550.110698] [099/133] (472s left) kms_addfb_basic (bad-pitch-999)
[550.174772] Starting subtest: bad-pitch-999
[550.177326] Subtest bad-pitch-999: SUCCESS (0.000s)
[550.326920] [100/133] (472s left) kms_prop_blob (basic)
[550.383570] Starting subtest: basic
[550.385552] Subtest basic: SUCCESS (0.000s)
[550.502900] [101/133] (472s left) syncobj_basic (bad-pad-fd-to-handle)
[550.569672] Starting subtest: bad-pad-fd-to-handle
[550.571639] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[550.692297] [102/133] (471s left) kms_cursor_crc (cursor-sliding-256x256)
[550.917900] Starting subtest: cursor-sliding-256x256
[550.920117] Starting dynamic subtest: pipe-A-eDP-1
[554.217416] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.297s)
[554.242854] Starting dynamic subtest: pipe-D-eDP-1
[558.084544] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.848s)
[558.086526] Subtest cursor-sliding-256x256: SUCCESS (7.169s)
[558.920191] [103/133] (463s left) gem_busy (busy)
[558.994335] Starting subtest: busy
[558.996621] Starting dynamic subtest: all-engines
[559.046906] Dynamic subtest all-engines: SUCCESS (0.055s)
[559.059435] Starting dynamic subtest: rcs0
[560.862820] Dynamic subtest rcs0: SUCCESS (1.813s)
[560.872732] Starting dynamic subtest: bcs0
[560.922671] Dynamic subtest bcs0: SUCCESS (0.057s)
[560.931847] Starting dynamic subtest: vcs0
[560.961788] Dynamic subtest vcs0: SUCCESS (0.039s)
[560.970204] Starting dynamic subtest: vcs1
[562.907505] Dynamic subtest vcs1: SUCCESS (1.942s)
[562.918246] Starting dynamic subtest: vecs0
[564.891438] Dynamic subtest vecs0: SUCCESS (1.982s)
[564.901750] Starting dynamic subtest: ccs0
[566.939766] Dynamic subtest ccs0: SUCCESS (2.048s)
[566.942052] Subtest busy: SUCCESS (7.947s)
[567.307438] [104/133] (455s left) i915_pm_rps (thresholds)
[567.379609] Starting subtest: thresholds
[567.384076] Subtest thresholds: SKIP (0.001s)
[567.502217] [105/133] (455s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[567.597811] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[567.600075] Starting dynamic subtest: pipe-A-eDP-1
[567.622051] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[567.631384] Starting dynamic subtest: pipe-B-eDP-1
[567.651581] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[567.660086] Starting dynamic subtest: pipe-C-eDP-1
[567.680764] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[567.689081] Starting dynamic subtest: pipe-D-eDP-1
[567.710944] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[567.715275] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[569.820655] [106/133] (452s left) gem_softpin (evict-snoop-interruptible)
[569.892138] Starting subtest: evict-snoop-interruptible
[569.896067] Subtest evict-snoop-interruptible: SKIP (0.000s)
[570.035559] [107/133] (452s left) gem_mmap_gtt (big-bo)
[570.103513] Subtest big-bo: SKIP (0.000s)
[570.181162] [108/133] (452s left) gem_partial_pwrite_pread (write-display)
[570.255229] Subtest write-display: SKIP (0.000s)
[570.342319] [109/133] (452s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[570.444213] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[570.446482] Starting dynamic subtest: pipe-A-eDP-1
[570.469189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[570.478428] Starting dynamic subtest: pipe-B-eDP-1
[570.500144] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[570.508603] Starting dynamic subtest: pipe-C-eDP-1
[570.530310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[570.538870] Starting dynamic subtest: pipe-D-eDP-1
[570.561225] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[570.565195] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[572.718162] [110/133] (450s left) kms_psr (fbc-pr-cursor-blt)
[572.811392] Starting subtest: fbc-pr-cursor-blt
[572.815523] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[572.895981] [111/133] (450s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[572.952816] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[572.955263] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[573.084890] [112/133] (449s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[573.152835] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[573.156750] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[573.359477] [113/133] (449s left) gem_mmap (basic)
[573.417293] Subtest basic: SKIP (0.000s)
[573.486515] [114/133] (449s left) gem_exec_gttfill (basic)
[573.541458] Starting subtest: basic
[576.082047] Subtest basic: SUCCESS (2.540s)
[576.282147] [115/133] (446s left) kms_addfb_basic (size-max)
[576.436076] Starting subtest: size-max
[576.438190] Subtest size-max: SUCCESS (0.000s)
[576.571036] [116/133] (446s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[576.681236] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[576.683453] Starting dynamic subtest: pipe-A-eDP-1
[576.706482] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[576.717356] Starting dynamic subtest: pipe-B-eDP-1
[576.739033] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[576.747937] Starting dynamic subtest: pipe-C-eDP-1
[576.769947] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[576.778880] Starting dynamic subtest: pipe-D-eDP-1
[576.802849] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[576.807100] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[578.916269] [117/133] (444s left) api_intel_bb (purge-bb)
[578.982918] Starting subtest: purge-bb
[578.988402] Subtest purge-bb: SUCCESS (0.005s)
[579.120362] [118/133] (444s left) kms_cursor_legacy (forked-move)
[579.237821] Starting subtest: forked-move
[579.240087] Starting dynamic subtest: pipe-A
[584.735164] Dynamic subtest pipe-A: SUCCESS (5.495s)
[584.747239] Starting dynamic subtest: pipe-B
[590.250271] Dynamic subtest pipe-B: SUCCESS (5.512s)
[590.261870] Starting dynamic subtest: pipe-C
[595.724022] Dynamic subtest pipe-C: SUCCESS (5.470s)
[595.736074] Starting dynamic subtest: pipe-D
[601.197841] Dynamic subtest pipe-D: SUCCESS (5.474s)
[601.209905] Starting dynamic subtest: all-pipes
[606.705330] Dynamic subtest all-pipes: SUCCESS (5.505s)
[606.707810] Subtest forked-move: SUCCESS (27.467s)
[606.890421] [119/133] (416s left) gen9_exec_parse (bb-chained)
[606.972575] Subtest bb-chained: SKIP (0.000s)
[607.065137] [120/133] (416s left) kms_concurrent (multi-plane-atomic-lowres)
[607.175411] Starting subtest: multi-plane-atomic-lowres
[607.177417] Starting dynamic subtest: pipe-A-eDP-1
[607.720692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[607.723118] Subtest multi-plane-atomic-lowres: SUCCESS (0.544s)
[608.626391] [121/133] (414s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[608.691671] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[608.767846] [122/133] (414s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[608.826999] Starting subtest: multi-wait-available-unsubmitted-submitted
[608.829380] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[608.934522] [123/133] (414s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[609.045279] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[613.501943] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.465s)
[614.740162] [124/133] (408s left) kms_pm_dc (dc3co-vpb-simulation)
[615.855427] Starting subtest: dc3co-vpb-simulation
[624.682067] Subtest dc3co-vpb-simulation: SKIP (8.823s)
[624.824261] [125/133] (398s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[624.934673] Starting subtest: x-tiled-8bpp-rotate-90
[624.954100] Subtest x-tiled-8bpp-rotate-90: SKIP (0.019s)
[625.067388] [126/133] (398s left) kms_plane_multiple (2x-tiling-none)
[625.158949] Starting subtest: 2x-tiling-none
[625.163245] Subtest 2x-tiling-none: SKIP (0.000s)
[625.241025] [127/133] (398s left) gem_exec_balancer (bonded-false-hang)
[625.501673] Starting subtest: bonded-false-hang
[625.506934] Subtest bonded-false-hang: SKIP (0.000s)
[625.631309] [128/133] (397s left) i915_drm_fdinfo (idle)
[625.673719] Starting subtest: idle
[625.675925] Starting dynamic subtest: rcs0
[626.234280] Dynamic subtest rcs0: SUCCESS (0.560s)
[626.245221] Starting dynamic subtest: bcs0
[626.777586] Dynamic subtest bcs0: SUCCESS (0.539s)
[626.789714] Starting dynamic subtest: vcs0
[627.281660] Dynamic subtest vcs0: SUCCESS (0.502s)
[627.291029] Starting dynamic subtest: vcs1
[627.784997] Dynamic subtest vcs1: SUCCESS (0.503s)
[627.796927] Starting dynamic subtest: vecs0
[628.291964] Dynamic subtest vecs0: SUCCESS (0.503s)
[628.303880] Starting dynamic subtest: ccs0
[628.797051] Dynamic subtest ccs0: SUCCESS (0.503s)
[628.799886] Subtest idle: SUCCESS (3.124s)
[628.883064] [129/133] (394s left) kms_getfb (getfb2-handle-closed)
[628.987690] Starting subtest: getfb2-handle-closed
[628.989799] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[629.100029] [130/133] (394s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[629.162074] Starting subtest: invalid-bsd1-flag-on-vebox
[629.164321] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[629.293915] [131/133] (394s left) kms_psr (fbc-pr-suspend)
[629.388206] Starting subtest: fbc-pr-suspend
[629.392282] Subtest fbc-pr-suspend: SKIP (0.000s)
[629.479316] [132/133] (394s left) gem_softpin (overlap)
[629.532837] Starting subtest: overlap
[630.347256] Subtest overlap: SUCCESS (0.813s)
[630.504391] [133/133] (393s left) gem_madvise (dontneed-before-mmap)
[630.534356] Starting subtest: dontneed-before-mmap
[630.561186] Subtest dontneed-before-mmap: SUCCESS (0.026s)
[630.683644] 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.