[57.368701] Initializing watchdogs
[57.368748]   /dev/watchdog0
[57.382828] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.387425] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.389590] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.392817] [001/133] (960s left) perf_pmu (busy-start)
[57.462426] Starting subtest: busy-start
[57.464619] Starting dynamic subtest: rcs0
[60.020865] Dynamic subtest rcs0: SUCCESS (2.557s)
[60.029073] Starting dynamic subtest: bcs0
[62.569734] Dynamic subtest bcs0: SUCCESS (2.549s)
[62.579877] Starting dynamic subtest: vcs0
[65.876071] Dynamic subtest vcs0: SUCCESS (3.304s)
[65.884571] Starting dynamic subtest: vcs1
[69.908579] Dynamic subtest vcs1: SUCCESS (4.032s)
[69.918626] Starting dynamic subtest: vecs0
[73.875366] Dynamic subtest vecs0: SUCCESS (3.966s)
[73.885082] Starting dynamic subtest: ccs0
[76.424739] Dynamic subtest ccs0: SUCCESS (2.548s)
[76.427342] Subtest busy-start: SUCCESS (18.962s)
[76.564173] [002/133] (941s left) gem_exec_flush (basic-wb-rw-before-default)
[76.636384] Starting subtest: basic-wb-rw-before-default
[82.096564] Subtest basic-wb-rw-before-default: SUCCESS (5.461s)
[82.295954] [003/133] (935s left) kms_lease (lessee-list)
[82.390474] Starting subtest: lessee-list
[82.392751] Starting dynamic subtest: pipe-A-eDP-1
[82.395079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[82.402720] Starting dynamic subtest: pipe-B-eDP-1
[82.404877] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[82.412132] Starting dynamic subtest: pipe-C-eDP-1
[82.414302] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[82.421305] Starting dynamic subtest: pipe-D-eDP-1
[82.423431] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[82.425643] Subtest lessee-list: SUCCESS (0.007s)
[82.516871] [004/133] (935s left) i915_drm_fdinfo (virtual-busy-hang-all)
[82.554041] Starting subtest: virtual-busy-hang-all
[82.558296] Subtest virtual-busy-hang-all: SKIP (0.000s)
[82.630511] [005/133] (935s left) kms_atomic_interruptible (legacy-setmode)
[82.729373] Starting subtest: legacy-setmode
[82.731542] Starting dynamic subtest: pipe-A-eDP-1
[89.614826] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.883s)
[89.617169] Subtest legacy-setmode: SUCCESS (6.884s)
[90.423453] [006/133] (927s left) kms_color (ctm-max)
[90.519287] Starting subtest: ctm-max
[90.521600] Starting dynamic subtest: pipe-A-eDP-1
[91.251385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[91.261000] Starting dynamic subtest: pipe-B-eDP-1
[92.622384] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.371s)
[92.631448] Starting dynamic subtest: pipe-C-eDP-1
[94.004596] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[94.013568] Starting dynamic subtest: pipe-D-eDP-1
[95.329655] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[95.332067] Subtest ctm-max: SUCCESS (4.809s)
[96.165850] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[96.272435] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[100.548407] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.279s)
[101.760358] [008/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[101.876293] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[101.880240] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[102.021630] [009/133] (916s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[102.128554] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[102.130692] Starting dynamic subtest: pipe-A
[102.152545] Dynamic subtest pipe-A: SKIP (0.020s)
[102.162417] Starting dynamic subtest: pipe-B
[102.192265] Dynamic subtest pipe-B: SKIP (0.037s)
[102.200837] Starting dynamic subtest: pipe-C
[102.222381] Dynamic subtest pipe-C: SKIP (0.032s)
[102.229668] Starting dynamic subtest: pipe-D
[102.253514] Dynamic subtest pipe-D: SKIP (0.031s)
[102.257599] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.121s)
[102.360775] [010/133] (915s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[102.466504] Starting subtest: y-tiled-64bpp-rotate-180
[102.470668] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[102.583915] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[102.688905] Starting subtest: primary-x-tiled-reflect-x-180
[109.745969] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.057s)
[110.923827] [012/133] (907s left) kms_flip (2x-flip-vs-expired-vblank)
[111.028221] Starting subtest: 2x-flip-vs-expired-vblank
[111.039979] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[111.126312] [013/133] (907s left) api_intel_allocator (fork-simple-stress)
[111.187500] Starting subtest: fork-simple-stress
[116.582328] Subtest fork-simple-stress: SUCCESS (5.398s)
[116.712062] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[116.813343] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[123.402112] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.592s)
[123.558926] [015/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[123.658170] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[123.662160] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[123.792403] [016/133] (894s left) gem_mmap (bad-size)
[123.856580] Subtest bad-size: SKIP (0.000s)
[123.913913] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[123.964044] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[123.968420] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[124.154689] [018/133] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[124.245854] Starting subtest: psr-2p-primscrn-cur-indfb-move
[124.250114] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[124.348239] [019/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[124.453357] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[130.997797] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.550s)
[131.158523] [020/133] (887s left) syncobj_timeline (wait-all-snapshot)
[131.225812] Starting subtest: wait-all-snapshot
[131.308059] Subtest wait-all-snapshot: SUCCESS (0.081s)
[131.400670] [021/133] (887s left) gem_partial_pwrite_pread (reads)
[131.460653] Subtest reads: SKIP (0.000s)
[131.531709] [022/133] (887s left) syncobj_basic (create-signaled)
[131.587219] Starting subtest: create-signaled
[131.589584] Subtest create-signaled: SUCCESS (0.000s)
[131.705492] [023/133] (887s left) kms_chamelium_frames (dp-crc-multiple)
[132.089486] Subtest dp-crc-multiple: SKIP (0.000s)
[132.864295] [024/133] (885s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[132.992541] Starting subtest: cursorA-vs-flipA-varying-size
[144.146306] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.151s)
[145.023786] [025/133] (873s left) gem_ctx_persistence (hang)
[145.092858] Starting subtest: hang
[145.097356] Subtest hang: SKIP (0.000s)
[145.210753] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[145.300730] Starting subtest: pr-primary-page-flip
[145.305216] Subtest pr-primary-page-flip: SKIP (0.000s)
[145.384365] [027/133] (873s left) gem_lmem_swapping (heavy-random)
[145.425655] Subtest heavy-random: SKIP (0.000s)
[145.469300] [028/133] (873s left) kms_addfb_basic (master-rmfb)
[145.533231] Starting subtest: master-rmfb
[145.535680] Subtest master-rmfb: SUCCESS (0.001s)
[145.693996] [029/133] (873s left) kms_addfb_basic (invalid-get-prop-any)
[145.749389] Starting subtest: invalid-get-prop-any
[145.751792] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[145.910770] [030/133] (873s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[146.012348] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[146.014328] Starting dynamic subtest: pipe-A-eDP-1
[146.035176] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.044658] Starting dynamic subtest: pipe-B-eDP-1
[146.064058] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[146.071042] Starting dynamic subtest: pipe-C-eDP-1
[146.090334] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[146.097175] Starting dynamic subtest: pipe-D-eDP-1
[146.116620] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[146.120145] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[148.304337] [031/133] (870s left) gem_exec_basic (basic)
[148.364322] Starting subtest: basic
[148.366682] Starting dynamic subtest: rcs0-smem
[148.368986] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[148.378519] Starting dynamic subtest: bcs0-smem
[148.380791] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[148.388381] Starting dynamic subtest: vcs0-smem
[148.390585] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[148.397883] Starting dynamic subtest: vcs1-smem
[148.400089] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[148.407369] Starting dynamic subtest: vecs0-smem
[148.409568] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[148.416914] Starting dynamic subtest: ccs0-smem
[148.419109] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[148.421272] Subtest basic: SUCCESS (0.014s)
[149.961429] [032/133] (869s left) gem_mmap_offset (oob-read)
[150.019363] Starting subtest: oob-read
[150.021633] Subtest oob-read: SUCCESS (0.000s)
[150.137492] [033/133] (868s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[150.239108] Starting subtest: bad-pixel-format-yf-tiled-ccs
[150.241366] Starting dynamic subtest: pipe-A-eDP-1
[150.264351] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[150.272992] Starting dynamic subtest: pipe-B-eDP-1
[150.293727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[150.301187] Starting dynamic subtest: pipe-C-eDP-1
[150.321888] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[150.329434] Starting dynamic subtest: pipe-D-eDP-1
[150.351671] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[150.356207] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[152.559292] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[152.750121] Starting subtest: cursor-random-64x21
[152.795732] Subtest cursor-random-64x21: SKIP (0.042s)
[153.065309] [035/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[153.165198] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[153.169208] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[153.272486] [036/133] (865s left) kms_plane_alpha_blend (constant-alpha-max)
[153.377628] Starting subtest: constant-alpha-max
[153.674169] Starting dynamic subtest: pipe-A-eDP-1
[154.728623] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.052s)
[154.736977] Starting dynamic subtest: pipe-D-eDP-1
[156.339396] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.609s)
[156.341702] Subtest constant-alpha-max: SUCCESS (2.962s)
[157.210608] [037/133] (862s left) gem_exec_fence (keep-in-fence)
[157.393552] Starting subtest: keep-in-fence
[157.395713] Starting dynamic subtest: rcs0
[157.466132] Dynamic subtest rcs0: SUCCESS (0.072s)
[157.475887] Starting dynamic subtest: bcs0
[157.518656] Dynamic subtest bcs0: SUCCESS (0.051s)
[157.528657] Starting dynamic subtest: vcs0
[158.932854] Dynamic subtest vcs0: SUCCESS (1.411s)
[158.943073] Starting dynamic subtest: vcs1
[160.916790] Dynamic subtest vcs1: SUCCESS (1.982s)
[160.927859] Starting dynamic subtest: vecs0
[162.901503] Dynamic subtest vecs0: SUCCESS (1.982s)
[162.911358] Starting dynamic subtest: ccs0
[163.128565] Dynamic subtest ccs0: SUCCESS (0.226s)
[163.131025] Subtest keep-in-fence: SUCCESS (5.736s)
[165.017772] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[165.021069] [038/133] (854s left) i915_pm_rps (min-max-config-idle)
[165.085269] Starting subtest: min-max-config-idle
[165.089968] Subtest min-max-config-idle: SKIP (0.002s)
[165.219454] [039/133] (854s left) dumb_buffer (map-invalid-size)
[165.276396] Starting subtest: map-invalid-size
[165.278717] Subtest map-invalid-size: SUCCESS (0.000s)
[165.418200] [040/133] (854s left) gem_mmap_gtt (basic-write-gtt)
[165.482692] Subtest basic-write-gtt: SKIP (0.000s)
[165.555255] [041/133] (853s left) gem_userptr_blits (set-cache-level)
[165.630117] Starting subtest: set-cache-level
[165.634316] Subtest set-cache-level: SKIP (0.000s)
[165.783979] [042/133] (853s left) kms_psr (psr-primary-render)
[165.899900] Starting subtest: psr-primary-render
[165.902242] Starting dynamic subtest: eDP-1
[167.605888] Dynamic subtest eDP-1: SUCCESS (1.704s)
[167.608158] Subtest psr-primary-render: SUCCESS (1.705s)
[168.478555] [043/133] (851s left) gem_create (create-ext-placement-sanity-check)
[168.643808] Starting subtest: create-ext-placement-sanity-check
[168.646280] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[168.795418] [044/133] (850s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[168.889078] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[168.897474] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[168.990834] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[169.060424] Starting subtest: u-lateslice
[169.062704] Starting dynamic subtest: rcs0
[169.072754] Dynamic subtest rcs0: SUCCESS (0.023s)
[169.085653] Starting dynamic subtest: bcs0
[169.095171] Dynamic subtest bcs0: SUCCESS (0.022s)
[169.106595] Starting dynamic subtest: vcs0
[169.116844] Dynamic subtest vcs0: SUCCESS (0.020s)
[169.126602] Starting dynamic subtest: vcs1
[169.136115] Dynamic subtest vcs1: SUCCESS (0.019s)
[169.148023] Starting dynamic subtest: vecs0
[169.154201] Dynamic subtest vecs0: SUCCESS (0.017s)
[169.162094] Starting dynamic subtest: ccs0
[169.171393] Dynamic subtest ccs0: SUCCESS (0.017s)
[169.173649] Subtest u-lateslice: SUCCESS (0.122s)
[171.000146] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[171.112229] Starting subtest: dpms-off-confusion-interruptible
[171.114562] Starting dynamic subtest: A-eDP1
[179.758516] Dynamic subtest A-eDP1: SUCCESS (8.645s)
[179.768793] Starting dynamic subtest: B-eDP1
[188.389910] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[188.398499] Starting dynamic subtest: C-eDP1
[196.999037] Dynamic subtest C-eDP1: SUCCESS (8.608s)
[197.007085] Starting dynamic subtest: D-eDP1
[205.627385] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[205.632686] Subtest dpms-off-confusion-interruptible: SUCCESS (34.519s)
[206.801149] [047/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[206.903584] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[213.765539] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.864s)
[213.927414] [048/133] (805s left) kms_plane (plane-position-hole)
[214.027770] Starting subtest: plane-position-hole
[214.531540] Starting dynamic subtest: pipe-A-plane-1
[215.821517] Dynamic subtest pipe-A-plane-1: SUCCESS (1.290s)
[215.830675] Starting dynamic subtest: pipe-A-plane-2
[217.111429] Dynamic subtest pipe-A-plane-2: SUCCESS (1.290s)
[217.120565] Starting dynamic subtest: pipe-A-plane-3
[218.345227] Dynamic subtest pipe-A-plane-3: SUCCESS (1.231s)
[218.355906] Starting dynamic subtest: pipe-A-plane-4
[219.569870] Dynamic subtest pipe-A-plane-4: SUCCESS (1.225s)
[219.578816] Starting dynamic subtest: pipe-A-plane-5
[219.596048] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[220.727373] Starting dynamic subtest: pipe-B-plane-1
[222.003378] Dynamic subtest pipe-B-plane-1: SUCCESS (1.283s)
[222.013180] Starting dynamic subtest: pipe-B-plane-2
[223.266321] Dynamic subtest pipe-B-plane-2: SUCCESS (1.259s)
[223.275471] Starting dynamic subtest: pipe-B-plane-3
[224.478555] Dynamic subtest pipe-B-plane-3: SUCCESS (1.213s)
[224.487859] Starting dynamic subtest: pipe-B-plane-4
[225.732198] Dynamic subtest pipe-B-plane-4: SUCCESS (1.251s)
[225.743278] Starting dynamic subtest: pipe-B-plane-5
[225.756896] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[225.758972] Subtest plane-position-hole: SUCCESS (11.729s)
[226.549365] [049/133] (793s left) kms_draw_crc (draw-method-mmap-cpu)
[226.647307] Starting subtest: draw-method-mmap-cpu
[226.649218] Starting dynamic subtest: xrgb8888-untiled
[226.911927] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[226.922838] Starting dynamic subtest: rgb565-untiled
[227.123232] Dynamic subtest rgb565-untiled: SUCCESS (0.209s)
[227.131244] Starting dynamic subtest: xrgb2101010-untiled
[227.334239] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[227.345022] Starting dynamic subtest: xbgr16161616f-untiled
[227.578463] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[227.586226] Starting dynamic subtest: xrgb8888-xtiled
[227.723059] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[227.731140] Starting dynamic subtest: rgb565-xtiled
[227.845102] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[227.853289] Starting dynamic subtest: xrgb2101010-xtiled
[227.967254] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[227.974879] Starting dynamic subtest: xbgr16161616f-xtiled
[228.089468] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[228.097428] Starting dynamic subtest: xrgb8888-4tiled
[228.222714] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[228.230526] Starting dynamic subtest: rgb565-4tiled
[228.356257] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[228.364309] Starting dynamic subtest: xrgb2101010-4tiled
[228.489474] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[228.497543] Starting dynamic subtest: xbgr16161616f-4tiled
[228.622904] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[228.624874] Subtest draw-method-mmap-cpu: SUCCESS (1.978s)
[228.741855] [050/133] (791s left) gem_mmap_gtt (medium-copy-xy)
[228.815910] Subtest medium-copy-XY: SKIP (0.000s)
[228.885720] [051/133] (791s left) vgem_basic (bad-flag)
[228.925377] Starting subtest: bad-flag
[228.927347] Subtest bad-flag: SUCCESS (0.000s)
[228.993870] [052/133] (790s left) gem_ctx_persistence (engines-hostile-preempt)
[229.051047] Starting subtest: engines-hostile-preempt
[229.053070] Starting dynamic subtest: rcs0
[229.155223] Dynamic subtest rcs0: SUCCESS (0.103s)
[229.165856] Starting dynamic subtest: bcs0
[229.223201] Dynamic subtest bcs0: SUCCESS (0.066s)
[229.235078] Starting dynamic subtest: vcs0
[230.953397] Dynamic subtest vcs0: SUCCESS (1.726s)
[230.964286] Starting dynamic subtest: vcs1
[232.938762] Dynamic subtest vcs1: SUCCESS (1.983s)
[232.950027] Starting dynamic subtest: vecs0
[234.927873] Dynamic subtest vecs0: SUCCESS (1.986s)
[234.939018] Starting dynamic subtest: ccs0
[234.991914] Dynamic subtest ccs0: SUCCESS (0.063s)
[234.994516] Subtest engines-hostile-preempt: SUCCESS (5.941s)
[235.085123] [053/133] (784s left) kms_sequence (queue-idle)
[235.190914] Starting subtest: queue-idle
[235.193273] Starting dynamic subtest: pipe-A-eDP-1
[236.990058] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.800s)
[236.999217] Starting dynamic subtest: pipe-B-eDP-1
[239.490737] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.497s)
[239.503711] Starting dynamic subtest: pipe-C-eDP-1
[241.926293] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.435s)
[241.935516] Starting dynamic subtest: pipe-D-eDP-1
[244.356152] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.431s)
[244.358433] Subtest queue-idle: SUCCESS (9.168s)
[245.187575] [054/133] (774s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[245.289708] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[245.292056] Starting dynamic subtest: pipe-A-eDP-1
[245.385401] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[245.396573] Starting dynamic subtest: pipe-B-eDP-1
[246.529203] Dynamic subtest pipe-B-eDP-1: SKIP (1.142s)
[246.533833] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.245s)
[247.819247] [055/133] (772s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[247.931201] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[247.935809] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[248.030524] [056/133] (772s left) kms_atomic (atomic-plane-damage)
[248.139972] Starting subtest: atomic-plane-damage
[248.187929] Starting dynamic subtest: pipe-A-eDP-1
[248.712795] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.525s)
[248.717326] Subtest atomic-plane-damage: SUCCESS (0.573s)
[249.552565] [057/133] (770s left) kms_big_fb (linear-16bpp-rotate-90)
[249.661613] Starting subtest: linear-16bpp-rotate-90
[249.680830] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[249.829130] [058/133] (770s left) perf (stress-open-close)
[249.954488] Starting subtest: stress-open-close
[249.956765] Starting dynamic subtest: 0-rcs0
[252.117060] Dynamic subtest 0-rcs0: SUCCESS (2.165s)
[252.125193] Starting dynamic subtest: 1-vcs1
[254.282030] Dynamic subtest 1-vcs1: SUCCESS (2.164s)
[254.284064] Subtest stress-open-close: SUCCESS (4.330s)
[254.322605] [059/133] (765s left) gem_workarounds (basic-read-fd)
[254.401545] Starting subtest: basic-read-fd
[254.415699] Subtest basic-read-fd: SUCCESS (0.014s)
[254.567426] [060/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[254.688496] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[255.813115] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.124s)
[255.962070] [061/133] (764s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[256.066767] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[256.070072] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[256.198258] [062/133] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[256.304846] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[256.308398] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[256.428326] [063/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[256.532827] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[256.536062] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[256.653641] [064/133] (763s left) kms_cursor_crc (cursor-offscreen-32x10)
[256.831465] Starting subtest: cursor-offscreen-32x10
[256.879279] Subtest cursor-offscreen-32x10: SKIP (0.044s)
[257.189513] [065/133] (763s left) kms_psr (psr2-primary-render)
[257.298939] Starting subtest: psr2-primary-render
[257.300821] Starting dynamic subtest: eDP-1
[259.017349] Dynamic subtest eDP-1: SUCCESS (1.715s)
[259.019629] Subtest psr2-primary-render: SUCCESS (1.716s)
[259.910007] [066/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[260.012537] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[260.016935] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[260.129270] [067/133] (760s left) gem_exec_schedule (noreorder-priority)
[260.310505] Starting subtest: noreorder-priority
[260.312831] Starting dynamic subtest: rcs0
[261.461331] Dynamic subtest rcs0: SUCCESS (1.153s)
[261.473719] Starting dynamic subtest: vcs0
[262.964036] Dynamic subtest vcs0: SUCCESS (1.500s)
[262.975418] Starting dynamic subtest: vcs1
[264.956286] Dynamic subtest vcs1: SUCCESS (1.990s)
[264.967648] Starting dynamic subtest: vecs0
[266.886436] Dynamic subtest vecs0: SUCCESS (1.928s)
[266.897913] Starting dynamic subtest: ccs0
[268.061571] Dynamic subtest ccs0: SUCCESS (1.174s)
[268.064057] Subtest noreorder-priority: SUCCESS (7.755s)
[268.262416] [068/133] (752s left) gem_softpin (allocator-evict)
[268.342159] Starting subtest: allocator-evict
[268.344357] Starting dynamic subtest: rcs0
[292.303298] Dynamic subtest rcs0: SUCCESS (23.962s)
[292.314688] Starting dynamic subtest: bcs0
[316.119366] Dynamic subtest bcs0: SUCCESS (23.813s)
[316.130044] Starting dynamic subtest: vcs0
[339.596420] Dynamic subtest vcs0: SUCCESS (23.476s)
[339.608273] Starting dynamic subtest: vcs1
[363.420369] Dynamic subtest vcs1: SUCCESS (23.821s)
[363.430135] Starting dynamic subtest: vecs0
[387.068761] Dynamic subtest vecs0: SUCCESS (23.647s)
[387.077864] Starting dynamic subtest: ccs0
[411.119607] Dynamic subtest ccs0: SUCCESS (24.048s)
[411.121864] Subtest allocator-evict: SUCCESS (142.777s)
[411.214517] [069/133] (609s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[411.359384] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[416.420558] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.064s)
[417.608602] [070/133] (603s left) gem_exec_reloc (basic-cpu-gtt-active)
[417.681086] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[417.764583] [071/133] (602s left) gem_ctx_shared (single-timeline)
[417.829042] Starting subtest: single-timeline
[417.849397] Subtest single-timeline: SUCCESS (0.013s)
[418.108096] [072/133] (602s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[418.169246] Starting subtest: etime-multi-wait-all-for-submit-submitted
[418.272353] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[418.361278] [073/133] (602s left) syncobj_timeline (etime-single-wait-all-submitted)
[418.424563] Starting subtest: etime-single-wait-all-submitted
[418.529111] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[418.617103] [074/133] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[419.015788] Subtest dp-hpd-storm: SKIP (0.000s)
[419.794479] [075/133] (601s left) kms_flip (2x-flip-vs-suspend)
[419.896945] Starting subtest: 2x-flip-vs-suspend
[419.906170] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[419.998428] [076/133] (600s left) kms_psr (fbc-psr2-sprite-plane-move)
[420.093575] Starting subtest: fbc-psr2-sprite-plane-move
[420.095693] Starting dynamic subtest: eDP-1
[420.099603] Dynamic subtest eDP-1: SKIP (0.000s)
[420.103572] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[420.177530] [077/133] (600s left) gem_exec_params (mmapped)
[420.248206] Starting subtest: mmapped
[420.253296] Subtest mmapped: SUCCESS (0.003s)
[420.410819] [078/133] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[420.520669] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[420.524727] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[420.646269] [079/133] (600s left) sw_sync (sync_merge_invalid)
[420.683262] Starting subtest: sync_merge_invalid
[420.706593] Subtest sync_merge_invalid: SUCCESS (0.027s)
[420.788121] [080/133] (600s left) perf_pmu (busy)
[420.827138] Starting subtest: busy
[420.828922] Starting dynamic subtest: rcs0
[421.420689] Dynamic subtest rcs0: SUCCESS (0.594s)
[421.431881] Starting dynamic subtest: bcs0
[421.989833] Dynamic subtest bcs0: SUCCESS (0.567s)
[422.000710] Starting dynamic subtest: vcs0
[423.892760] Dynamic subtest vcs0: SUCCESS (1.899s)
[423.904049] Starting dynamic subtest: vcs1
[425.940593] Dynamic subtest vcs1: SUCCESS (2.045s)
[425.952300] Starting dynamic subtest: vecs0
[427.924533] Dynamic subtest vecs0: SUCCESS (1.981s)
[427.936207] Starting dynamic subtest: ccs0
[428.492242] Dynamic subtest ccs0: SUCCESS (0.567s)
[428.494684] Subtest busy: SUCCESS (7.667s)
[428.608116] [081/133] (592s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[428.665087] Starting subtest: multi-wait-for-submit-submitted-signaled
[428.667412] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[428.796064] [082/133] (592s left) gem_mmap_wc (write-wc-read-gtt)
[428.848407] Subtest write-wc-read-gtt: SKIP (0.000s)
[428.919935] [083/133] (592s left) kms_hdmi_inject (inject-audio)
[429.267373] Starting subtest: inject-audio
[429.542483] Subtest inject-audio: SUCCESS (0.277s)
[430.193547] [084/133] (591s left) kms_flip (2x-blocking-wf_vblank)
[430.283356] Starting subtest: 2x-blocking-wf_vblank
[430.292121] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[430.383910] [085/133] (590s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[430.472980] Starting subtest: plane-all-transition-nonblocking-fencing
[430.475287] Starting dynamic subtest: pipe-A-eDP-1
[432.966918] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[433.285762] Starting dynamic subtest: pipe-B-eDP-1
[436.553913] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.278s)
[436.852703] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.379s)
[437.670772] [086/133] (583s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[437.799083] Starting subtest: flip-vs-cursor-crc-legacy
[438.467742] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.669s)
[439.362994] [087/133] (582s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[439.459755] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[439.463733] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[439.540506] [088/133] (581s left) gem_exec_params (invalid-ring2)
[439.594589] Starting subtest: invalid-ring2
[439.597015] Subtest invalid-ring2: SUCCESS (0.000s)
[439.717562] [089/133] (581s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[439.806660] Starting subtest: fbcpsr-slowdraw
[464.944435] Subtest fbcpsr-slowdraw: SUCCESS (25.140s)
[465.127841] [090/133] (556s left) kms_joiner (basic-force-ultra-joiner)
[465.239831] Starting subtest: basic-force-ultra-joiner
[465.243941] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[465.325826] [091/133] (556s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[465.425986] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[465.451588] Starting dynamic subtest: pipe-A-plane-0
[465.740388] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[465.749196] Starting dynamic subtest: pipe-A-plane-3
[465.973260] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[467.109587] Starting dynamic subtest: pipe-B-plane-0
[467.391341] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[467.400574] Starting dynamic subtest: pipe-B-plane-3
[467.624623] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[467.933077] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.508s)
[468.756381] [092/133] (552s left) kms_vblank (query-forked-busy-hang)
[468.864176] Starting subtest: query-forked-busy-hang
[468.866510] Starting dynamic subtest: pipe-A-eDP-1
[495.652832] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.789s)
[495.666377] Starting dynamic subtest: pipe-D-eDP-1
[510.670690] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.013s)
[510.673246] Subtest query-forked-busy-hang: SUCCESS (41.808s)
[511.564425] [093/133] (510s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[511.665563] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[511.669884] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[511.761494] [094/133] (509s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[511.888694] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[512.480778] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.594s)
[512.675655] [095/133] (509s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[512.766269] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[512.768536] Starting dynamic subtest: pipe-A-default-mode
[515.432461] Dynamic subtest pipe-A-default-mode: SUCCESS (2.666s)
[515.434774] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.667s)
[516.265097] [096/133] (505s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[516.332313] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[516.440445] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[516.528411] [097/133] (505s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[516.645158] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[516.649607] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[516.780495] [098/133] (505s left) gem_exec_whisper (basic-fds-forked)
[516.837691] Starting subtest: basic-fds-forked
[539.960233] Subtest basic-fds-forked: SUCCESS (23.118s)
[540.151448] [099/133] (481s left) kms_addfb_basic (bad-pitch-999)
[540.217725] Starting subtest: bad-pitch-999
[540.220114] Subtest bad-pitch-999: SUCCESS (0.000s)
[540.388766] [100/133] (481s left) kms_prop_blob (basic)
[540.445857] Starting subtest: basic
[540.447823] Subtest basic: SUCCESS (0.000s)
[540.574348] [101/133] (481s left) syncobj_basic (bad-pad-fd-to-handle)
[540.640496] Starting subtest: bad-pad-fd-to-handle
[540.642890] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[540.761033] [102/133] (481s left) kms_cursor_crc (cursor-sliding-256x256)
[541.011979] Starting subtest: cursor-sliding-256x256
[541.017324] Starting dynamic subtest: pipe-A-eDP-1
[544.282926] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.267s)
[544.317411] Starting dynamic subtest: pipe-D-eDP-1
[548.292383] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.987s)
[548.294733] Subtest cursor-sliding-256x256: SUCCESS (7.282s)
[549.175396] [103/133] (472s left) gem_busy (busy)
[549.235474] Starting subtest: busy
[549.237933] Starting dynamic subtest: all-engines
[549.296656] Dynamic subtest all-engines: SUCCESS (0.061s)
[549.306282] Starting dynamic subtest: rcs0
[550.875292] Dynamic subtest rcs0: SUCCESS (1.576s)
[550.886258] Starting dynamic subtest: bcs0
[550.936936] Dynamic subtest bcs0: SUCCESS (0.058s)
[550.946538] Starting dynamic subtest: vcs0
[550.974075] Dynamic subtest vcs0: SUCCESS (0.038s)
[550.983388] Starting dynamic subtest: vcs1
[552.921749] Dynamic subtest vcs1: SUCCESS (1.944s)
[552.932825] Starting dynamic subtest: vecs0
[554.906764] Dynamic subtest vecs0: SUCCESS (1.983s)
[554.917706] Starting dynamic subtest: ccs0
[556.891991] Dynamic subtest ccs0: SUCCESS (1.985s)
[556.894142] Subtest busy: SUCCESS (7.655s)
[557.266812] [104/133] (464s left) i915_pm_rps (thresholds)
[557.341272] Starting subtest: thresholds
[557.345848] Subtest thresholds: SKIP (0.001s)
[557.477431] [105/133] (464s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[557.592055] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[557.594303] Starting dynamic subtest: pipe-A-eDP-1
[557.616806] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[557.627293] Starting dynamic subtest: pipe-B-eDP-1
[557.649250] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[557.657616] Starting dynamic subtest: pipe-C-eDP-1
[557.679980] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[557.688641] Starting dynamic subtest: pipe-D-eDP-1
[557.711191] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[557.715261] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[559.854365] [106/133] (462s left) gem_softpin (evict-snoop-interruptible)
[559.918717] Starting subtest: evict-snoop-interruptible
[559.923278] Subtest evict-snoop-interruptible: SKIP (0.000s)
[560.058987] [107/133] (462s left) gem_mmap_gtt (big-bo)
[560.131274] Subtest big-bo: SKIP (0.000s)
[560.200661] [108/133] (462s left) gem_partial_pwrite_pread (write-display)
[560.257591] Subtest write-display: SKIP (0.000s)
[560.340011] [109/133] (461s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[560.444541] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[560.446680] Starting dynamic subtest: pipe-A-eDP-1
[560.467745] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[560.477587] Starting dynamic subtest: pipe-B-eDP-1
[560.498242] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[560.506374] Starting dynamic subtest: pipe-C-eDP-1
[560.526976] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[560.535109] Starting dynamic subtest: pipe-D-eDP-1
[560.557060] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[560.561339] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[562.745870] [110/133] (459s left) kms_psr (fbc-pr-cursor-blt)
[562.842752] Starting subtest: fbc-pr-cursor-blt
[562.847058] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[562.939478] [111/133] (459s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[562.998119] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[563.000136] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[563.114783] [112/133] (459s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[563.173767] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[563.178205] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[563.367163] [113/133] (459s left) gem_mmap (basic)
[563.428759] Subtest basic: SKIP (0.000s)
[563.497957] [114/133] (459s left) gem_exec_gttfill (basic)
[563.562232] Starting subtest: basic
[565.994834] Subtest basic: SUCCESS (2.433s)
[566.189832] [115/133] (456s left) kms_addfb_basic (size-max)
[566.332743] Starting subtest: size-max
[566.335056] Subtest size-max: SUCCESS (0.000s)
[566.445925] [116/133] (456s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[566.534656] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[566.536893] Starting dynamic subtest: pipe-A-eDP-1
[566.559284] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[566.568655] Starting dynamic subtest: pipe-B-eDP-1
[566.590306] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[566.598888] Starting dynamic subtest: pipe-C-eDP-1
[566.620941] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[566.630076] Starting dynamic subtest: pipe-D-eDP-1
[566.651577] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[566.655944] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[568.860803] [117/133] (453s left) api_intel_bb (purge-bb)
[568.938831] Starting subtest: purge-bb
[568.947366] Subtest purge-bb: SUCCESS (0.011s)
[569.119931] [118/133] (453s left) kms_cursor_legacy (forked-move)
[569.244299] Starting subtest: forked-move
[569.246582] Starting dynamic subtest: pipe-A
[574.720392] Dynamic subtest pipe-A: SUCCESS (5.472s)
[574.732099] Starting dynamic subtest: pipe-B
[580.192956] Dynamic subtest pipe-B: SUCCESS (5.470s)
[580.204094] Starting dynamic subtest: pipe-C
[585.663954] Dynamic subtest pipe-C: SUCCESS (5.468s)
[585.675669] Starting dynamic subtest: pipe-D
[591.147342] Dynamic subtest pipe-D: SUCCESS (5.481s)
[591.158607] Starting dynamic subtest: all-pipes
[596.646720] Dynamic subtest all-pipes: SUCCESS (5.497s)
[596.649598] Subtest forked-move: SUCCESS (27.400s)
[596.815657] [119/133] (425s left) gen9_exec_parse (bb-chained)
[596.882340] Subtest bb-chained: SKIP (0.000s)
[596.954418] [120/133] (425s left) kms_concurrent (multi-plane-atomic-lowres)
[597.050904] Starting subtest: multi-plane-atomic-lowres
[597.053254] Starting dynamic subtest: pipe-A-eDP-1
[597.553405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[597.555855] Subtest multi-plane-atomic-lowres: SUCCESS (0.503s)
[598.424533] [121/133] (424s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[598.491114] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[598.558926] [122/133] (424s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[598.624489] Starting subtest: multi-wait-available-unsubmitted-submitted
[598.626818] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[598.742387] [123/133] (424s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[598.844637] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[603.327572] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.487s)
[604.463322] [124/133] (418s left) kms_pm_dc (dc3co-vpb-simulation)
[605.585041] Starting subtest: dc3co-vpb-simulation
[614.367264] Subtest dc3co-vpb-simulation: SKIP (8.778s)
[614.519865] [125/133] (408s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[614.631057] Starting subtest: x-tiled-8bpp-rotate-90
[614.651234] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[614.839408] [126/133] (408s left) kms_plane_multiple (2x-tiling-none)
[614.942693] Starting subtest: 2x-tiling-none
[614.947208] Subtest 2x-tiling-none: SKIP (0.000s)
[615.026965] [127/133] (408s left) gem_exec_balancer (bonded-false-hang)
[615.297415] Starting subtest: bonded-false-hang
[615.302613] Subtest bonded-false-hang: SKIP (0.000s)
[615.432226] [128/133] (407s left) i915_drm_fdinfo (idle)
[615.472063] Starting subtest: idle
[615.473934] Starting dynamic subtest: rcs0
[616.079315] Dynamic subtest rcs0: SUCCESS (0.608s)
[616.090828] Starting dynamic subtest: bcs0
[616.590500] Dynamic subtest bcs0: SUCCESS (0.504s)
[616.601073] Starting dynamic subtest: vcs0
[617.092601] Dynamic subtest vcs0: SUCCESS (0.503s)
[617.104097] Starting dynamic subtest: vcs1
[617.597609] Dynamic subtest vcs1: SUCCESS (0.503s)
[617.609195] Starting dynamic subtest: vecs0
[618.103367] Dynamic subtest vecs0: SUCCESS (0.503s)
[618.114986] Starting dynamic subtest: ccs0
[618.609439] Dynamic subtest ccs0: SUCCESS (0.503s)
[618.612404] Subtest idle: SUCCESS (3.139s)
[618.720724] [129/133] (404s left) kms_getfb (getfb2-handle-closed)
[618.823941] Starting subtest: getfb2-handle-closed
[618.826317] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[618.966727] [130/133] (404s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[619.034532] Starting subtest: invalid-bsd1-flag-on-vebox
[619.036918] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[619.168741] [131/133] (404s left) kms_psr (fbc-pr-suspend)
[619.269960] Starting subtest: fbc-pr-suspend
[619.274271] Subtest fbc-pr-suspend: SKIP (0.000s)
[619.358181] [132/133] (403s left) gem_softpin (overlap)
[619.431792] Starting subtest: overlap
[620.283285] Subtest overlap: SUCCESS (0.855s)
[620.437892] [133/133] (402s left) gem_madvise (dontneed-before-mmap)
[620.471838] Starting subtest: dontneed-before-mmap
[620.501676] Subtest dontneed-before-mmap: SUCCESS (0.031s)
[620.615320] 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.