[58.102112] Initializing watchdogs
[58.102160]   /dev/watchdog0
[58.116092] [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.120484] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.122768] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.126438] [001/133] (960s left) perf_pmu (busy-start)
[58.191292] Starting subtest: busy-start
[58.193842] Starting dynamic subtest: rcs0
[60.746457] Dynamic subtest rcs0: SUCCESS (2.555s)
[60.755684] Starting dynamic subtest: bcs0
[63.296980] Dynamic subtest bcs0: SUCCESS (2.549s)
[63.306565] Starting dynamic subtest: vcs0
[67.045078] Dynamic subtest vcs0: SUCCESS (3.746s)
[67.054853] Starting dynamic subtest: vcs1
[70.932091] Dynamic subtest vcs1: SUCCESS (3.886s)
[70.940911] Starting dynamic subtest: vecs0
[74.899526] Dynamic subtest vecs0: SUCCESS (3.967s)
[74.907883] Starting dynamic subtest: ccs0
[77.448889] Dynamic subtest ccs0: SUCCESS (2.549s)
[77.451666] Subtest busy-start: SUCCESS (19.258s)
[77.573341] [002/133] (941s left) gem_exec_flush (basic-wb-rw-before-default)
[77.639175] Starting subtest: basic-wb-rw-before-default
[83.105709] Subtest basic-wb-rw-before-default: SUCCESS (5.469s)
[83.308599] [003/133] (935s left) kms_lease (lessee-list)
[83.405969] Starting subtest: lessee-list
[83.408707] Starting dynamic subtest: pipe-A-eDP-1
[83.411804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[83.425144] Starting dynamic subtest: pipe-B-eDP-1
[83.427388] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[83.434996] Starting dynamic subtest: pipe-C-eDP-1
[83.437162] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[83.444115] Starting dynamic subtest: pipe-D-eDP-1
[83.446288] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[83.448462] Subtest lessee-list: SUCCESS (0.007s)
[83.533336] [004/133] (935s left) i915_drm_fdinfo (virtual-busy-hang-all)
[83.569306] Starting subtest: virtual-busy-hang-all
[83.573726] Subtest virtual-busy-hang-all: SKIP (0.000s)
[83.642404] [005/133] (935s left) kms_atomic_interruptible (legacy-setmode)
[83.735631] Starting subtest: legacy-setmode
[83.737917] Starting dynamic subtest: pipe-A-eDP-1
[90.611320] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.875s)
[90.613738] Subtest legacy-setmode: SUCCESS (6.876s)
[91.411946] [006/133] (927s left) kms_color (ctm-max)
[91.510460] Starting subtest: ctm-max
[91.512832] Starting dynamic subtest: pipe-A-eDP-1
[92.222182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[92.231360] Starting dynamic subtest: pipe-B-eDP-1
[93.616501] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s)
[93.624750] Starting dynamic subtest: pipe-C-eDP-1
[95.010607] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[95.019247] Starting dynamic subtest: pipe-D-eDP-1
[96.328756] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[96.331177] Subtest ctm-max: SUCCESS (4.818s)
[97.143426] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[97.246866] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[101.509971] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.267s)
[102.649688] [008/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[102.758387] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[102.762434] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[102.883597] [009/133] (916s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[102.982805] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[102.985222] Starting dynamic subtest: pipe-A
[103.007047] Dynamic subtest pipe-A: SKIP (0.018s)
[103.029426] Starting dynamic subtest: pipe-B
[103.038741] Dynamic subtest pipe-B: SKIP (0.032s)
[103.046584] Starting dynamic subtest: pipe-C
[103.069250] Dynamic subtest pipe-C: SKIP (0.032s)
[103.076642] Starting dynamic subtest: pipe-D
[103.100961] Dynamic subtest pipe-D: SKIP (0.032s)
[103.105341] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.115s)
[103.227363] [010/133] (915s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[103.331060] Starting subtest: y-tiled-64bpp-rotate-180
[103.335450] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[103.456363] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[103.551208] Starting subtest: primary-x-tiled-reflect-x-180
[110.593521] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.043s)
[111.840084] [012/133] (907s left) kms_flip (2x-flip-vs-expired-vblank)
[111.951997] Starting subtest: 2x-flip-vs-expired-vblank
[111.961095] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[112.085053] [013/133] (907s left) api_intel_allocator (fork-simple-stress)
[112.146743] Starting subtest: fork-simple-stress
[117.543765] Subtest fork-simple-stress: SUCCESS (5.397s)
[117.694191] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[117.819298] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[124.363526] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.547s)
[124.507554] [015/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[124.611543] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[124.615812] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[124.712052] [016/133] (894s left) gem_mmap (bad-size)
[124.767576] Subtest bad-size: SKIP (0.000s)
[124.822679] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[124.878583] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[124.882943] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[125.068402] [018/133] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[125.164958] Starting subtest: psr-2p-primscrn-cur-indfb-move
[125.169193] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[125.287774] [019/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[125.393853] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[132.087086] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.697s)
[132.220245] [020/133] (887s left) syncobj_timeline (wait-all-snapshot)
[132.279726] Starting subtest: wait-all-snapshot
[132.360936] Subtest wait-all-snapshot: SUCCESS (0.081s)
[132.457057] [021/133] (886s left) gem_partial_pwrite_pread (reads)
[132.530532] Subtest reads: SKIP (0.000s)
[132.613740] [022/133] (886s left) syncobj_basic (create-signaled)
[132.675875] Starting subtest: create-signaled
[132.678256] Subtest create-signaled: SUCCESS (0.000s)
[132.811631] [023/133] (886s left) kms_chamelium_frames (dp-crc-multiple)
[133.204890] Subtest dp-crc-multiple: SKIP (0.000s)
[133.982100] [024/133] (885s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[134.115039] Starting subtest: cursorA-vs-flipA-varying-size
[145.268642] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.152s)
[146.136643] [025/133] (873s left) gem_ctx_persistence (hang)
[146.208643] Starting subtest: hang
[146.213389] Subtest hang: SKIP (0.000s)
[146.356692] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[146.450217] Starting subtest: pr-primary-page-flip
[146.454494] Subtest pr-primary-page-flip: SKIP (0.000s)
[146.545596] [027/133] (873s left) gem_lmem_swapping (heavy-random)
[146.583475] Subtest heavy-random: SKIP (0.000s)
[146.628069] [028/133] (873s left) kms_addfb_basic (master-rmfb)
[146.693356] Starting subtest: master-rmfb
[146.695785] Subtest master-rmfb: SUCCESS (0.002s)
[146.868307] [029/133] (872s left) kms_addfb_basic (invalid-get-prop-any)
[146.930978] Starting subtest: invalid-get-prop-any
[146.933074] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[147.086486] [030/133] (872s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[147.187213] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[147.189160] Starting dynamic subtest: pipe-A-eDP-1
[147.210508] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.220342] Starting dynamic subtest: pipe-B-eDP-1
[147.239299] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.246794] Starting dynamic subtest: pipe-C-eDP-1
[147.266154] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.273629] Starting dynamic subtest: pipe-D-eDP-1
[147.295058] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.298538] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[149.511620] [031/133] (870s left) gem_exec_basic (basic)
[149.575798] Starting subtest: basic
[149.577985] Starting dynamic subtest: rcs0-smem
[149.580253] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[149.588695] Starting dynamic subtest: bcs0-smem
[149.590577] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[149.597898] Starting dynamic subtest: vcs0-smem
[149.599810] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[149.607126] Starting dynamic subtest: vcs1-smem
[149.608977] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[149.616145] Starting dynamic subtest: vecs0-smem
[149.618054] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[149.625609] Starting dynamic subtest: ccs0-smem
[149.627508] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[149.629420] Subtest basic: SUCCESS (0.014s)
[150.919266] [032/133] (868s left) gem_mmap_offset (oob-read)
[150.982085] Starting subtest: oob-read
[150.984458] Subtest oob-read: SUCCESS (0.001s)
[151.113138] [033/133] (868s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[151.212178] Starting subtest: bad-pixel-format-yf-tiled-ccs
[151.214469] Starting dynamic subtest: pipe-A-eDP-1
[151.236956] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.245148] Starting dynamic subtest: pipe-B-eDP-1
[151.266760] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.274195] Starting dynamic subtest: pipe-C-eDP-1
[151.295850] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.303659] Starting dynamic subtest: pipe-D-eDP-1
[151.325342] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.329470] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[153.488866] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[153.700281] Starting subtest: cursor-random-64x21
[153.748526] Subtest cursor-random-64x21: SKIP (0.043s)
[153.986203] [035/133] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[154.092568] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[154.096632] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[154.219737] [036/133] (865s left) kms_plane_alpha_blend (constant-alpha-max)
[154.317770] Starting subtest: constant-alpha-max
[154.603391] Starting dynamic subtest: pipe-A-eDP-1
[155.588523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.985s)
[155.597359] Starting dynamic subtest: pipe-D-eDP-1
[157.187201] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.595s)
[157.189477] Subtest constant-alpha-max: SUCCESS (2.870s)
[158.053172] [037/133] (861s left) gem_exec_fence (keep-in-fence)
[158.239711] Starting subtest: keep-in-fence
[158.242090] Starting dynamic subtest: rcs0
[158.310569] Dynamic subtest rcs0: SUCCESS (0.074s)
[158.321580] Starting dynamic subtest: bcs0
[158.365610] Dynamic subtest bcs0: SUCCESS (0.053s)
[158.375597] Starting dynamic subtest: vcs0
[159.893058] Dynamic subtest vcs0: SUCCESS (1.524s)
[159.902856] Starting dynamic subtest: vcs1
[161.941304] Dynamic subtest vcs1: SUCCESS (2.046s)
[161.950863] Starting dynamic subtest: vecs0
[163.924717] Dynamic subtest vecs0: SUCCESS (1.981s)
[163.933905] Starting dynamic subtest: ccs0
[164.161530] Dynamic subtest ccs0: SUCCESS (0.236s)
[164.164133] Subtest keep-in-fence: SUCCESS (5.926s)
[166.033362] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[166.036261] [038/133] (854s left) i915_pm_rps (min-max-config-idle)
[166.095969] Starting subtest: min-max-config-idle
[166.100870] Subtest min-max-config-idle: SKIP (0.001s)
[166.237382] [039/133] (853s left) dumb_buffer (map-invalid-size)
[166.288842] Starting subtest: map-invalid-size
[166.291035] Subtest map-invalid-size: SUCCESS (0.000s)
[166.424972] [040/133] (853s left) gem_mmap_gtt (basic-write-gtt)
[166.483108] Subtest basic-write-gtt: SKIP (0.000s)
[166.546296] [041/133] (853s left) gem_userptr_blits (set-cache-level)
[166.610484] Starting subtest: set-cache-level
[166.615166] Subtest set-cache-level: SKIP (0.000s)
[166.764080] [042/133] (853s left) kms_psr (psr-primary-render)
[166.863846] Starting subtest: psr-primary-render
[166.866068] Starting dynamic subtest: eDP-1
[168.634924] Dynamic subtest eDP-1: SUCCESS (1.771s)
[168.637245] Subtest psr-primary-render: SUCCESS (1.772s)
[169.503663] [043/133] (850s left) gem_create (create-ext-placement-sanity-check)
[169.673694] Starting subtest: create-ext-placement-sanity-check
[169.676175] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[169.801359] [044/133] (850s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[169.892911] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[169.902393] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[169.996617] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[170.077949] Starting subtest: u-lateslice
[170.080280] Starting dynamic subtest: rcs0
[170.087879] Dynamic subtest rcs0: SUCCESS (0.022s)
[170.097191] Starting dynamic subtest: bcs0
[170.106693] Dynamic subtest bcs0: SUCCESS (0.018s)
[170.114675] Starting dynamic subtest: vcs0
[170.125924] Dynamic subtest vcs0: SUCCESS (0.019s)
[170.133934] Starting dynamic subtest: vcs1
[170.143963] Dynamic subtest vcs1: SUCCESS (0.018s)
[170.151936] Starting dynamic subtest: vecs0
[170.162851] Dynamic subtest vecs0: SUCCESS (0.018s)
[170.170728] Starting dynamic subtest: ccs0
[170.180708] Dynamic subtest ccs0: SUCCESS (0.018s)
[170.182931] Subtest u-lateslice: SUCCESS (0.116s)
[172.046017] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[172.149348] Starting subtest: dpms-off-confusion-interruptible
[172.151601] Starting dynamic subtest: A-eDP1
[180.797522] Dynamic subtest A-eDP1: SUCCESS (8.646s)
[180.805319] Starting dynamic subtest: B-eDP1
[189.427464] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[189.437614] Starting dynamic subtest: C-eDP1
[198.055766] Dynamic subtest C-eDP1: SUCCESS (8.627s)
[198.065271] Starting dynamic subtest: D-eDP1
[206.691454] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[206.697096] Subtest dpms-off-confusion-interruptible: SUCCESS (34.545s)
[207.875535] [047/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[207.978040] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[214.764826] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.789s)
[214.949436] [048/133] (805s left) kms_plane (plane-position-hole)
[215.049160] Starting subtest: plane-position-hole
[215.561783] Starting dynamic subtest: pipe-A-plane-1
[216.864395] Dynamic subtest pipe-A-plane-1: SUCCESS (1.302s)
[216.873240] Starting dynamic subtest: pipe-A-plane-2
[218.113583] Dynamic subtest pipe-A-plane-2: SUCCESS (1.247s)
[218.123698] Starting dynamic subtest: pipe-A-plane-3
[219.388419] Dynamic subtest pipe-A-plane-3: SUCCESS (1.275s)
[219.397288] Starting dynamic subtest: pipe-A-plane-4
[220.681856] Dynamic subtest pipe-A-plane-4: SUCCESS (1.291s)
[220.690847] Starting dynamic subtest: pipe-A-plane-5
[220.706627] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[221.855095] Starting dynamic subtest: pipe-B-plane-1
[223.172857] Dynamic subtest pipe-B-plane-1: SUCCESS (1.323s)
[223.181031] Starting dynamic subtest: pipe-B-plane-2
[224.502633] Dynamic subtest pipe-B-plane-2: SUCCESS (1.328s)
[224.511560] Starting dynamic subtest: pipe-B-plane-3
[225.761656] Dynamic subtest pipe-B-plane-3: SUCCESS (1.259s)
[225.771126] Starting dynamic subtest: pipe-B-plane-4
[227.074155] Dynamic subtest pipe-B-plane-4: SUCCESS (1.311s)
[227.083088] Starting dynamic subtest: pipe-B-plane-5
[227.100731] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[227.102893] Subtest plane-position-hole: SUCCESS (12.052s)
[227.873630] [049/133] (792s left) kms_draw_crc (draw-method-mmap-cpu)
[227.967234] Starting subtest: draw-method-mmap-cpu
[227.969122] Starting dynamic subtest: xrgb8888-untiled
[228.186609] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[228.195268] Starting dynamic subtest: rgb565-untiled
[228.408968] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[228.417351] Starting dynamic subtest: xrgb2101010-untiled
[228.631179] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[228.639394] Starting dynamic subtest: xbgr16161616f-untiled
[228.864174] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.231s)
[228.872175] Starting dynamic subtest: xrgb8888-xtiled
[228.986482] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[229.002321] Starting dynamic subtest: rgb565-xtiled
[229.108795] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[229.119240] Starting dynamic subtest: xrgb2101010-xtiled
[229.230810] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[229.239136] Starting dynamic subtest: xbgr16161616f-xtiled
[229.399299] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.166s)
[229.407074] Starting dynamic subtest: xrgb8888-4tiled
[229.553043] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s)
[229.562546] Starting dynamic subtest: rgb565-4tiled
[229.697329] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[229.705667] Starting dynamic subtest: xrgb2101010-4tiled
[229.830868] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[229.839373] Starting dynamic subtest: xbgr16161616f-4tiled
[229.975158] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[229.976934] Subtest draw-method-mmap-cpu: SUCCESS (2.011s)
[230.090689] [050/133] (790s left) gem_mmap_gtt (medium-copy-xy)
[230.153964] Subtest medium-copy-XY: SKIP (0.000s)
[230.225869] [051/133] (790s left) vgem_basic (bad-flag)
[230.267844] Starting subtest: bad-flag
[230.269571] Subtest bad-flag: SUCCESS (0.000s)
[230.336521] [052/133] (790s left) gem_ctx_persistence (engines-hostile-preempt)
[230.382665] Starting subtest: engines-hostile-preempt
[230.384537] Starting dynamic subtest: rcs0
[230.491357] Dynamic subtest rcs0: SUCCESS (0.108s)
[230.504679] Starting dynamic subtest: bcs0
[230.525127] Dynamic subtest bcs0: SUCCESS (0.032s)
[230.532497] Starting dynamic subtest: vcs0
[231.919072] Dynamic subtest vcs0: SUCCESS (1.391s)
[231.930471] Starting dynamic subtest: vcs1
[233.960850] Dynamic subtest vcs1: SUCCESS (2.040s)
[233.971309] Starting dynamic subtest: vecs0
[235.943058] Dynamic subtest vecs0: SUCCESS (1.980s)
[235.954389] Starting dynamic subtest: ccs0
[236.022789] Dynamic subtest ccs0: SUCCESS (0.078s)
[236.025600] Subtest engines-hostile-preempt: SUCCESS (5.640s)
[236.122307] [053/133] (784s left) kms_sequence (queue-idle)
[236.209238] Starting subtest: queue-idle
[236.211725] Starting dynamic subtest: pipe-A-eDP-1
[238.020435] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[238.029427] Starting dynamic subtest: pipe-B-eDP-1
[240.531518] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.510s)
[240.542091] Starting dynamic subtest: pipe-C-eDP-1
[242.950579] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.417s)
[242.960690] Starting dynamic subtest: pipe-D-eDP-1
[245.390048] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s)
[245.392326] Subtest queue-idle: SUCCESS (9.181s)
[246.210711] [054/133] (774s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[246.305744] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[246.307996] Starting dynamic subtest: pipe-A-eDP-1
[246.384500] Dynamic subtest pipe-A-eDP-1: SKIP (0.081s)
[246.392655] Starting dynamic subtest: pipe-B-eDP-1
[247.478449] Dynamic subtest pipe-B-eDP-1: SKIP (1.092s)
[247.483073] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.176s)
[248.712542] [055/133] (772s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[248.819840] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[248.824388] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[248.929919] [056/133] (771s left) kms_atomic (atomic-plane-damage)
[249.032283] Starting subtest: atomic-plane-damage
[249.082547] Starting dynamic subtest: pipe-A-eDP-1
[249.646268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[249.649285] Subtest atomic-plane-damage: SUCCESS (0.616s)
[250.533586] [057/133] (770s left) kms_big_fb (linear-16bpp-rotate-90)
[250.632974] Starting subtest: linear-16bpp-rotate-90
[250.652319] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[250.789947] [058/133] (770s left) perf (stress-open-close)
[250.922979] Starting subtest: stress-open-close
[250.925309] Starting dynamic subtest: 0-rcs0
[253.090051] Dynamic subtest 0-rcs0: SUCCESS (2.169s)
[253.098961] Starting dynamic subtest: 1-vcs1
[255.252932] Dynamic subtest 1-vcs1: SUCCESS (2.162s)
[255.254802] Subtest stress-open-close: SUCCESS (4.332s)
[255.293649] [059/133] (765s left) gem_workarounds (basic-read-fd)
[255.363059] Starting subtest: basic-read-fd
[255.379226] Subtest basic-read-fd: SUCCESS (0.016s)
[255.523916] [060/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[255.627325] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[256.774186] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.146s)
[256.943880] [061/133] (764s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[257.048914] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[257.052543] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[257.189936] [062/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[257.291088] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[257.294756] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[257.417194] [063/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[257.516305] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[257.519868] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[257.640612] [064/133] (763s left) kms_cursor_crc (cursor-offscreen-32x10)
[257.813364] Starting subtest: cursor-offscreen-32x10
[257.861394] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[258.147298] [065/133] (763s left) kms_psr (psr2-primary-render)
[258.240157] Starting subtest: psr2-primary-render
[258.242087] Starting dynamic subtest: eDP-1
[260.001418] Dynamic subtest eDP-1: SUCCESS (1.758s)
[260.003763] Subtest psr2-primary-render: SUCCESS (1.759s)
[260.886042] [066/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[261.001054] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[261.005215] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[261.116621] [067/133] (760s left) gem_exec_schedule (noreorder-priority)
[261.298933] Starting subtest: noreorder-priority
[261.301775] Starting dynamic subtest: rcs0
[262.454302] Dynamic subtest rcs0: SUCCESS (1.155s)
[262.465649] Starting dynamic subtest: vcs0
[263.902321] Dynamic subtest vcs0: SUCCESS (1.444s)
[263.911860] Starting dynamic subtest: vcs1
[265.915819] Dynamic subtest vcs1: SUCCESS (2.010s)
[265.927326] Starting dynamic subtest: vecs0
[267.925337] Dynamic subtest vecs0: SUCCESS (2.008s)
[267.936773] Starting dynamic subtest: ccs0
[269.096070] Dynamic subtest ccs0: SUCCESS (1.169s)
[269.098613] Subtest noreorder-priority: SUCCESS (7.799s)
[269.294465] [068/133] (752s left) gem_softpin (allocator-evict)
[269.355636] Starting subtest: allocator-evict
[269.358060] Starting dynamic subtest: rcs0
[293.225094] Dynamic subtest rcs0: SUCCESS (23.867s)
[293.236604] Starting dynamic subtest: bcs0
[317.007415] Dynamic subtest bcs0: SUCCESS (23.777s)
[317.025189] Starting dynamic subtest: vcs0
[340.636310] Dynamic subtest vcs0: SUCCESS (23.626s)
[340.647066] Starting dynamic subtest: vcs1
[364.276256] Dynamic subtest vcs1: SUCCESS (23.638s)
[364.285277] Starting dynamic subtest: vecs0
[388.211381] Dynamic subtest vecs0: SUCCESS (23.933s)
[388.223123] Starting dynamic subtest: ccs0
[411.703031] Dynamic subtest ccs0: SUCCESS (23.490s)
[411.705520] Subtest allocator-evict: SUCCESS (142.342s)
[411.800285] [069/133] (609s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[411.953508] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[416.863063] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.912s)
[417.980414] [070/133] (603s left) gem_exec_reloc (basic-cpu-gtt-active)
[418.053118] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[418.122043] [071/133] (603s left) gem_ctx_shared (single-timeline)
[418.194258] Starting subtest: single-timeline
[418.215567] Subtest single-timeline: SUCCESS (0.017s)
[418.476168] [072/133] (603s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[418.549411] Starting subtest: etime-multi-wait-all-for-submit-submitted
[418.657344] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[418.744367] [073/133] (602s left) syncobj_timeline (etime-single-wait-all-submitted)
[418.802085] Starting subtest: etime-single-wait-all-submitted
[418.905461] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[418.995088] [074/133] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[419.384925] Subtest dp-hpd-storm: SKIP (0.000s)
[420.173190] [075/133] (601s left) kms_flip (2x-flip-vs-suspend)
[420.274299] Starting subtest: 2x-flip-vs-suspend
[420.285860] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[420.430582] [076/133] (601s left) kms_psr (fbc-psr2-sprite-plane-move)
[420.535967] Starting subtest: fbc-psr2-sprite-plane-move
[420.538206] Starting dynamic subtest: eDP-1
[420.542227] Dynamic subtest eDP-1: SKIP (0.000s)
[420.546283] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[420.622765] [077/133] (601s left) gem_exec_params (mmapped)
[420.688159] Starting subtest: mmapped
[420.690576] Subtest mmapped: SUCCESS (0.002s)
[420.829099] [078/133] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[420.930237] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[420.934217] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[421.064523] [079/133] (600s left) sw_sync (sync_merge_invalid)
[421.105634] Starting subtest: sync_merge_invalid
[421.130205] Subtest sync_merge_invalid: SUCCESS (0.027s)
[421.236266] [080/133] (600s left) perf_pmu (busy)
[421.272107] Starting subtest: busy
[421.273822] Starting dynamic subtest: rcs0
[421.899872] Dynamic subtest rcs0: SUCCESS (0.629s)
[421.910178] Starting dynamic subtest: bcs0
[422.469754] Dynamic subtest bcs0: SUCCESS (0.568s)
[422.480196] Starting dynamic subtest: vcs0
[423.892457] Dynamic subtest vcs0: SUCCESS (1.419s)
[423.902677] Starting dynamic subtest: vcs1
[425.940903] Dynamic subtest vcs1: SUCCESS (2.046s)
[425.951565] Starting dynamic subtest: vecs0
[427.860465] Dynamic subtest vecs0: SUCCESS (1.916s)
[427.872556] Starting dynamic subtest: ccs0
[428.437182] Dynamic subtest ccs0: SUCCESS (0.576s)
[428.439751] Subtest busy: SUCCESS (7.168s)
[428.566108] [081/133] (593s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[428.627582] Starting subtest: multi-wait-for-submit-submitted-signaled
[428.629906] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[428.754440] [082/133] (593s left) gem_mmap_wc (write-wc-read-gtt)
[428.819940] Subtest write-wc-read-gtt: SKIP (0.000s)
[428.889970] [083/133] (593s left) kms_hdmi_inject (inject-audio)
[429.237639] Starting subtest: inject-audio
[429.518695] Subtest inject-audio: SUCCESS (0.282s)
[430.190261] [084/133] (591s left) kms_flip (2x-blocking-wf_vblank)
[430.293543] Starting subtest: 2x-blocking-wf_vblank
[430.302323] Subtest 2x-blocking-wf_vblank: SKIP (0.012s)
[430.407793] [085/133] (591s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[430.506060] Starting subtest: plane-all-transition-nonblocking-fencing
[430.508170] Starting dynamic subtest: pipe-A-eDP-1
[433.000849] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[433.305167] Starting dynamic subtest: pipe-B-eDP-1
[436.526547] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.230s)
[436.820470] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.316s)
[437.652874] [086/133] (584s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[437.779644] Starting subtest: flip-vs-cursor-crc-legacy
[438.474400] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.694s)
[439.339893] [087/133] (582s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[439.448077] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[439.452057] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[439.539911] [088/133] (582s left) gem_exec_params (invalid-ring2)
[439.611570] Starting subtest: invalid-ring2
[439.613836] Subtest invalid-ring2: SUCCESS (0.000s)
[439.721965] [089/133] (582s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[439.846525] Starting subtest: fbcpsr-slowdraw
[465.023430] Subtest fbcpsr-slowdraw: SUCCESS (25.177s)
[465.204273] [090/133] (557s left) kms_joiner (basic-force-ultra-joiner)
[465.309268] Starting subtest: basic-force-ultra-joiner
[465.313479] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[465.388709] [091/133] (556s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[465.486823] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[465.513145] Starting dynamic subtest: pipe-A-plane-0
[465.812835] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[465.822770] Starting dynamic subtest: pipe-A-plane-3
[466.045817] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[467.170071] Starting dynamic subtest: pipe-B-plane-0
[467.463228] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[467.472085] Starting dynamic subtest: pipe-B-plane-3
[467.696769] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[468.033448] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.546s)
[468.840733] [092/133] (553s left) kms_vblank (query-forked-busy-hang)
[468.933277] Starting subtest: query-forked-busy-hang
[468.935450] Starting dynamic subtest: pipe-A-eDP-1
[495.649360] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.716s)
[495.663322] Starting dynamic subtest: pipe-D-eDP-1
[520.657998] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.004s)
[520.660246] Subtest query-forked-busy-hang: SUCCESS (51.724s)
[521.539322] [093/133] (500s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[521.645072] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[521.649139] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[521.775112] [094/133] (500s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[521.877067] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[522.479745] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.604s)
[522.675982] [095/133] (499s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[522.777319] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[522.779664] Starting dynamic subtest: pipe-A-default-mode
[525.505440] Dynamic subtest pipe-A-default-mode: SUCCESS (2.728s)
[525.507863] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.730s)
[526.333683] [096/133] (496s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[526.392911] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[526.497160] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[526.621639] [097/133] (496s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[526.732307] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[526.736908] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[526.862427] [098/133] (495s left) gem_exec_whisper (basic-fds-forked)
[526.931782] Starting subtest: basic-fds-forked
[550.068776] Subtest basic-fds-forked: SUCCESS (23.133s)
[550.286342] [099/133] (472s left) kms_addfb_basic (bad-pitch-999)
[550.339745] Starting subtest: bad-pitch-999
[550.341953] Subtest bad-pitch-999: SUCCESS (0.000s)
[550.497901] [100/133] (472s left) kms_prop_blob (basic)
[550.556804] Starting subtest: basic
[550.558782] Subtest basic: SUCCESS (0.000s)
[550.674552] [101/133] (472s left) syncobj_basic (bad-pad-fd-to-handle)
[550.723341] Starting subtest: bad-pad-fd-to-handle
[550.725687] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[550.836803] [102/133] (472s left) kms_cursor_crc (cursor-sliding-256x256)
[551.070354] Starting subtest: cursor-sliding-256x256
[551.075336] Starting dynamic subtest: pipe-A-eDP-1
[554.326235] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.252s)
[554.357716] Starting dynamic subtest: pipe-D-eDP-1
[558.350090] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.000s)
[558.352433] Subtest cursor-sliding-256x256: SUCCESS (7.278s)
[559.221134] [103/133] (463s left) gem_busy (busy)
[559.291423] Starting subtest: busy
[559.293346] Starting dynamic subtest: all-engines
[559.355186] Dynamic subtest all-engines: SUCCESS (0.066s)
[559.364762] Starting dynamic subtest: rcs0
[560.860914] Dynamic subtest rcs0: SUCCESS (1.503s)
[560.871525] Starting dynamic subtest: bcs0
[560.926062] Dynamic subtest bcs0: SUCCESS (0.062s)
[560.936065] Starting dynamic subtest: vcs0
[560.965177] Dynamic subtest vcs0: SUCCESS (0.038s)
[560.974318] Starting dynamic subtest: vcs1
[562.907734] Dynamic subtest vcs1: SUCCESS (1.939s)
[562.918761] Starting dynamic subtest: vecs0
[564.889321] Dynamic subtest vecs0: SUCCESS (1.979s)
[564.900539] Starting dynamic subtest: ccs0
[566.938494] Dynamic subtest ccs0: SUCCESS (2.048s)
[566.940533] Subtest busy: SUCCESS (7.647s)
[567.290401] [104/133] (455s left) i915_pm_rps (thresholds)
[567.354640] Starting subtest: thresholds
[567.359279] Subtest thresholds: SKIP (0.001s)
[567.484776] [105/133] (455s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[567.581327] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[567.583539] Starting dynamic subtest: pipe-A-eDP-1
[567.606526] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[567.616962] Starting dynamic subtest: pipe-B-eDP-1
[567.639107] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[567.649678] Starting dynamic subtest: pipe-C-eDP-1
[567.671608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[567.681507] Starting dynamic subtest: pipe-D-eDP-1
[567.703444] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[567.707474] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[569.849325] [106/133] (453s left) gem_softpin (evict-snoop-interruptible)
[569.923044] Starting subtest: evict-snoop-interruptible
[569.927334] Subtest evict-snoop-interruptible: SKIP (0.000s)
[570.084583] [107/133] (453s left) gem_mmap_gtt (big-bo)
[570.146704] Subtest big-bo: SKIP (0.000s)
[570.214130] [108/133] (452s left) gem_partial_pwrite_pread (write-display)
[570.275671] Subtest write-display: SKIP (0.000s)
[570.363120] [109/133] (452s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[570.459183] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[570.461376] Starting dynamic subtest: pipe-A-eDP-1
[570.484192] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[570.495051] Starting dynamic subtest: pipe-B-eDP-1
[570.516585] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[570.525580] Starting dynamic subtest: pipe-C-eDP-1
[570.547290] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[570.556656] Starting dynamic subtest: pipe-D-eDP-1
[570.580727] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[570.585466] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[572.724062] [110/133] (450s left) kms_psr (fbc-pr-cursor-blt)
[572.829262] Starting subtest: fbc-pr-cursor-blt
[572.833319] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[572.922635] [111/133] (450s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[572.983127] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[572.985389] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[573.096209] [112/133] (450s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[573.164638] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[573.168924] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[573.375392] [113/133] (449s left) gem_mmap (basic)
[573.441596] Subtest basic: SKIP (0.000s)
[573.512211] [114/133] (449s left) gem_exec_gttfill (basic)
[573.577586] Starting subtest: basic
[576.552056] Subtest basic: SUCCESS (2.973s)
[576.756178] [115/133] (446s left) kms_addfb_basic (size-max)
[576.909096] Starting subtest: size-max
[576.911298] Subtest size-max: SUCCESS (0.000s)
[577.032118] [116/133] (446s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[577.128776] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[577.131053] Starting dynamic subtest: pipe-A-eDP-1
[577.153490] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[577.167551] Starting dynamic subtest: pipe-B-eDP-1
[577.189203] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[577.197936] Starting dynamic subtest: pipe-C-eDP-1
[577.219692] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[577.228494] Starting dynamic subtest: pipe-D-eDP-1
[577.251070] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[577.255155] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[579.419715] [117/133] (444s left) api_intel_bb (purge-bb)
[579.485748] Starting subtest: purge-bb
[579.488139] Subtest purge-bb: SUCCESS (0.003s)
[579.641333] [118/133] (443s left) kms_cursor_legacy (forked-move)
[579.757516] Starting subtest: forked-move
[579.759975] Starting dynamic subtest: pipe-A
[585.213371] Dynamic subtest pipe-A: SUCCESS (5.452s)
[585.224756] Starting dynamic subtest: pipe-B
[590.686601] Dynamic subtest pipe-B: SUCCESS (5.470s)
[590.699380] Starting dynamic subtest: pipe-C
[596.157745] Dynamic subtest pipe-C: SUCCESS (5.468s)
[596.170878] Starting dynamic subtest: pipe-D
[601.623603] Dynamic subtest pipe-D: SUCCESS (5.464s)
[601.638629] Starting dynamic subtest: all-pipes
[607.130313] Dynamic subtest all-pipes: SUCCESS (5.503s)
[607.132969] Subtest forked-move: SUCCESS (27.369s)
[607.309347] [119/133] (416s left) gen9_exec_parse (bb-chained)
[607.371289] Subtest bb-chained: SKIP (0.000s)
[607.449931] [120/133] (416s left) kms_concurrent (multi-plane-atomic-lowres)
[607.549973] Starting subtest: multi-plane-atomic-lowres
[607.552176] Starting dynamic subtest: pipe-A-eDP-1
[608.066053] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.513s)
[608.068772] Subtest multi-plane-atomic-lowres: SUCCESS (0.514s)
[608.906432] [121/133] (414s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[608.981908] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[609.069763] [122/133] (414s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[609.140213] Starting subtest: multi-wait-available-unsubmitted-submitted
[609.142634] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[609.255109] [123/133] (414s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[609.352536] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[613.792315] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.443s)
[614.924812] [124/133] (408s left) kms_pm_dc (dc3co-vpb-simulation)
[616.031243] Starting subtest: dc3co-vpb-simulation
[625.116276] Subtest dc3co-vpb-simulation: SKIP (9.081s)
[625.297200] [125/133] (398s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[625.404536] Starting subtest: x-tiled-8bpp-rotate-90
[625.426534] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[625.601412] [126/133] (398s left) kms_plane_multiple (2x-tiling-none)
[625.695273] Starting subtest: 2x-tiling-none
[625.699656] Subtest 2x-tiling-none: SKIP (0.000s)
[625.781987] [127/133] (398s left) gem_exec_balancer (bonded-false-hang)
[626.054604] Starting subtest: bonded-false-hang
[626.059663] Subtest bonded-false-hang: SKIP (0.000s)
[626.162226] [128/133] (397s left) i915_drm_fdinfo (idle)
[626.208690] Starting subtest: idle
[626.210915] Starting dynamic subtest: rcs0
[626.771635] Dynamic subtest rcs0: SUCCESS (0.563s)
[626.781785] Starting dynamic subtest: bcs0
[627.307888] Dynamic subtest bcs0: SUCCESS (0.532s)
[627.318300] Starting dynamic subtest: vcs0
[627.814292] Dynamic subtest vcs0: SUCCESS (0.503s)
[627.824615] Starting dynamic subtest: vcs1
[628.319112] Dynamic subtest vcs1: SUCCESS (0.503s)
[628.328353] Starting dynamic subtest: vecs0
[628.825533] Dynamic subtest vecs0: SUCCESS (0.503s)
[628.835629] Starting dynamic subtest: ccs0
[629.331295] Dynamic subtest ccs0: SUCCESS (0.503s)
[629.333969] Subtest idle: SUCCESS (3.122s)
[629.420175] [129/133] (394s left) kms_getfb (getfb2-handle-closed)
[629.529931] Starting subtest: getfb2-handle-closed
[629.532189] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[629.641668] [130/133] (394s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[629.707362] Starting subtest: invalid-bsd1-flag-on-vebox
[629.709630] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[629.817199] [131/133] (394s left) kms_psr (fbc-pr-suspend)
[629.908271] Starting subtest: fbc-pr-suspend
[629.912586] Subtest fbc-pr-suspend: SKIP (0.000s)
[630.007288] [132/133] (394s left) gem_softpin (overlap)
[630.083091] Starting subtest: overlap
[630.946078] Subtest overlap: SUCCESS (0.861s)
[631.084807] [133/133] (393s left) gem_madvise (dontneed-before-mmap)
[631.117036] Starting subtest: dontneed-before-mmap
[631.141587] Subtest dontneed-before-mmap: SUCCESS (0.024s)
[631.262765] 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.