[55.943488] Initializing watchdogs
[55.943537]   /dev/watchdog0
[55.957997] [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]
[55.962473] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.964487] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.966483] [001/131] (960s left) kms_psr (fbc-pr-primary-page-flip)
[56.069040] Starting subtest: fbc-pr-primary-page-flip
[56.071120] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[56.130196] [002/131] (960s left) api_intel_bb (blit-reloc-purge-cache)
[56.177692] Starting subtest: blit-reloc-purge-cache
[56.179522] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[56.298673] [003/131] (960s left) gem_exec_balancer (bonded-dual)
[56.368224] Starting subtest: bonded-dual
[56.370191] Subtest bonded-dual: SKIP (0.000s)
[56.649239] [004/131] (959s left) gem_ctx_persistence (idempotent)
[56.707369] Starting subtest: idempotent
[56.708441] Subtest idempotent: SUCCESS (0.000s)
[56.811673] [005/131] (959s left) drm_read (fault-buffer)
[56.982294] Starting subtest: fault-buffer
[56.983363] Subtest fault-buffer: SUCCESS (0.001s)
[57.118199] [006/131] (959s left) kms_draw_crc (draw-method-mmap-wc)
[57.211282] Starting subtest: draw-method-mmap-wc
[57.212263] Starting dynamic subtest: xrgb8888-untiled
[57.412746] Dynamic subtest xrgb8888-untiled: SUCCESS (0.200s)
[57.419407] Starting dynamic subtest: rgb565-untiled
[57.591718] Dynamic subtest rgb565-untiled: SUCCESS (0.178s)
[57.598478] Starting dynamic subtest: xrgb2101010-untiled
[57.781698] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.189s)
[57.787602] Starting dynamic subtest: xbgr16161616f-untiled
[57.960755] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.178s)
[57.966872] Starting dynamic subtest: xrgb8888-xtiled
[58.083751] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[58.089761] Starting dynamic subtest: rgb565-xtiled
[58.206944] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[58.212229] Starting dynamic subtest: xrgb2101010-xtiled
[58.318178] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[58.323728] Starting dynamic subtest: xbgr16161616f-xtiled
[58.441423] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[58.448936] Starting dynamic subtest: xrgb8888-4tiled
[58.597924] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[58.605580] Starting dynamic subtest: rgb565-4tiled
[58.742944] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[58.749406] Starting dynamic subtest: xrgb2101010-4tiled
[58.866069] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[58.874091] Starting dynamic subtest: xbgr16161616f-4tiled
[59.033461] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[59.034980] Subtest draw-method-mmap-wc: SUCCESS (1.812s)
[59.136310] [007/131] (957s left) gem_exec_flush (basic-batch-kernel-default-wb)
[59.188358] Starting subtest: basic-batch-kernel-default-wb
[66.289040] Subtest basic-batch-kernel-default-wb: SUCCESS (7.076s)
[66.469317] [008/131] (950s left) kms_plane (plane-panning-top-left)
[66.559557] Starting subtest: plane-panning-top-left
[66.560612] Starting dynamic subtest: pipe-A
[68.207770] Dynamic subtest pipe-A: SUCCESS (1.644s)
[68.214986] Starting dynamic subtest: pipe-B
[70.463283] Dynamic subtest pipe-B: SUCCESS (2.252s)
[70.464299] Subtest plane-panning-top-left: SUCCESS (3.897s)
[71.326407] [009/131] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[71.567892] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[71.569844] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[71.793088] [010/131] (944s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[71.897078] Starting subtest: async-flip-with-page-flip-events-tiled
[72.267171] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[75.063389] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[75.070275] Starting dynamic subtest: pipe-A-eDP-1-4
[77.239107] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[77.247070] Starting dynamic subtest: pipe-A-eDP-1-4
[79.250513] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[79.259732] Starting dynamic subtest: pipe-A-eDP-1-x
[81.439975] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[81.809963] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[84.595076] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[84.603454] Starting dynamic subtest: pipe-B-eDP-1-4
[86.784520] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.187s)
[86.793041] Starting dynamic subtest: pipe-B-eDP-1-4
[88.792280] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[88.801117] Starting dynamic subtest: pipe-B-eDP-1-x
[90.983728] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[91.356182] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[94.131570] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.780s)
[94.137522] Starting dynamic subtest: pipe-C-eDP-1-4
[96.306989] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[96.315713] Starting dynamic subtest: pipe-C-eDP-1-4
[98.318216] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[98.324456] Starting dynamic subtest: pipe-C-eDP-1-x
[100.486160] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.168s)
[100.844867] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[103.668140] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.825s)
[103.675583] Starting dynamic subtest: pipe-D-eDP-1-4
[105.832860] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.164s)
[105.838605] Starting dynamic subtest: pipe-D-eDP-1-4
[107.842792] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[107.848222] Starting dynamic subtest: pipe-D-eDP-1-x
[110.022081] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.179s)
[110.023083] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.109s)
[111.246243] [011/131] (905s left) syncobj_timeline (invalid-query-bad-pad)
[111.309556] Starting subtest: invalid-query-bad-pad
[111.310560] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[111.405204] [012/131] (905s left) gem_readwrite (new-obj)
[111.456576] Subtest new-obj: SKIP (0.000s)
[111.509636] [013/131] (905s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[111.593743] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[111.594834] Starting dynamic subtest: pipe-A-eDP-1
[111.604238] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[111.611890] Starting dynamic subtest: pipe-B-eDP-1
[111.621268] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[111.626891] Starting dynamic subtest: pipe-C-eDP-1
[111.635079] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[111.640443] Starting dynamic subtest: pipe-D-eDP-1
[111.648901] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[111.650551] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[113.727372] [014/131] (903s left) kms_psr (fbc-psr-suspend)
[113.815110] Starting subtest: fbc-psr-suspend
[113.816085] Starting dynamic subtest: eDP-1
[113.817838] Dynamic subtest eDP-1: SKIP (0.000s)
[113.819605] Subtest fbc-psr-suspend: SKIP (0.000s)
[113.875871] [015/131] (903s left) i915_suspend (fence-restore-tiled2untiled)
[113.927386] Starting subtest: fence-restore-tiled2untiled
[113.929526] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[114.021976] [016/131] (902s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[114.140459] Starting subtest: 2x-long-flip-vs-cursor-legacy
[114.143041] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[114.275339] [017/131] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[114.371464] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[121.636534] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.266s)
[121.761925] [018/131] (895s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[121.858407] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[121.860312] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[121.959313] [019/131] (895s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[122.046719] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[122.048288] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[122.146997] [020/131] (894s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[122.240967] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[122.242909] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[122.323227] [021/131] (894s left) gem_mmap_wc (write-prefaulted)
[122.364359] Subtest write-prefaulted: SKIP (0.000s)
[122.426423] [022/131] (894s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[122.546707] Starting subtest: cursorB-vs-flipA-atomic
[122.548894] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[122.682360] [023/131] (894s left) gem_eio (wait-10ms)
[122.893946] Starting subtest: wait-10ms
[123.226589] Subtest wait-10ms: SUCCESS (0.333s)
[123.372433] [024/131] (893s left) kms_plane_multiple (tiling-x)
[123.451709] Starting subtest: tiling-x
[123.452811] Starting dynamic subtest: pipe-A-eDP-1
[127.088281] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.634s)
[127.097552] Starting dynamic subtest: pipe-B-eDP-1
[131.449884] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.360s)
[131.456256] Starting dynamic subtest: pipe-C-eDP-1
[135.772455] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.322s)
[135.779404] Starting dynamic subtest: pipe-D-eDP-1
[140.105210] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.332s)
[140.106207] Subtest tiling-x: SUCCESS (16.652s)
[140.924710] [025/131] (876s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[141.017680] Starting subtest: read-crc-frame-sequence
[141.018656] Starting dynamic subtest: pipe-A-eDP-1
[141.685123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.666s)
[141.691991] Starting dynamic subtest: pipe-B-eDP-1
[143.060885] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s)
[143.067781] Starting dynamic subtest: pipe-C-eDP-1
[144.342934] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.281s)
[144.349435] Starting dynamic subtest: pipe-D-eDP-1
[145.710554] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.367s)
[145.711524] Subtest read-crc-frame-sequence: SUCCESS (4.693s)
[146.544927] [026/131] (870s left) kms_lease (atomic-implicit-crtc)
[146.636614] Starting subtest: atomic-implicit-crtc
[146.637563] Starting dynamic subtest: pipe-A-eDP-1
[146.642170] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[146.649274] Starting dynamic subtest: pipe-B-eDP-1
[146.653510] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[146.659833] Starting dynamic subtest: pipe-C-eDP-1
[146.664111] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[146.670616] Starting dynamic subtest: pipe-D-eDP-1
[146.674629] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[146.675518] Subtest atomic-implicit-crtc: SUCCESS (0.029s)
[146.770834] [027/131] (870s left) gen9_exec_parse (batch-without-end)
[146.825640] Subtest batch-without-end: SKIP (0.000s)
[146.884696] [028/131] (870s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[151.858329] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[151.859334] Starting dynamic subtest: pipe-A-eDP-1
[169.014494] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.155s)
[169.021106] Starting dynamic subtest: pipe-B-eDP-1
[186.169443] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.154s)
[186.170439] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.313s)
[186.955833] [029/131] (830s left) i915_pm_rpm (system-suspend-devices)
[189.083401] Starting subtest: system-suspend-devices
[196.747644] Subtest system-suspend-devices: SUCCESS (7.666s)
[203.124476] [030/131] (820s left) kms_invalid_mode (bad-hsync-end)
[203.234307] Starting subtest: bad-hsync-end
[203.235124] Starting dynamic subtest: pipe-A-eDP-1
[203.522041] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[203.529048] Starting dynamic subtest: pipe-B-eDP-1
[203.529975] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[203.536719] Starting dynamic subtest: pipe-C-eDP-1
[203.537681] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[203.544445] Starting dynamic subtest: pipe-D-eDP-1
[203.545396] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[203.546382] Subtest bad-hsync-end: SUCCESS (0.292s)
[204.329449] [031/131] (819s left) gem_softpin (softpin)
[204.390277] Starting subtest: softpin
[236.686720] Subtest softpin: SUCCESS (32.290s)
[236.798420] [032/131] (786s left) gem_exec_reloc (basic-wc-gtt)
[236.858222] Subtest basic-wc-gtt: SKIP (0.000s)
[236.936597] [033/131] (786s left) sysfs_preempt_timeout (invalid)
[236.988403] Starting subtest: invalid
[236.989372] Starting dynamic subtest: vecs0
[236.990326] Dynamic subtest vecs0: SUCCESS (0.000s)
[236.997064] Starting dynamic subtest: ccs0
[236.997953] Dynamic subtest ccs0: SUCCESS (0.000s)
[237.004457] Starting dynamic subtest: vcs0
[237.005407] Dynamic subtest vcs0: SUCCESS (0.000s)
[237.011814] Starting dynamic subtest: bcs0
[237.012749] Dynamic subtest bcs0: SUCCESS (0.000s)
[237.019361] Starting dynamic subtest: rcs0
[237.020297] Dynamic subtest rcs0: SUCCESS (0.000s)
[237.026780] Starting dynamic subtest: vcs1
[237.027749] Dynamic subtest vcs1: SUCCESS (0.000s)
[237.028697] Subtest invalid: SUCCESS (0.005s)
[237.118790] [034/131] (786s left) gem_exec_schedule (preempt)
[237.177983] Starting subtest: preempt
[237.178850] Starting dynamic subtest: rcs0
[237.217240] Dynamic subtest rcs0: SUCCESS (0.038s)
[237.227495] Starting dynamic subtest: bcs0
[237.248978] Dynamic subtest bcs0: SUCCESS (0.031s)
[237.257463] Starting dynamic subtest: vcs0
[237.275334] Dynamic subtest vcs0: SUCCESS (0.026s)
[237.281718] Starting dynamic subtest: vcs1
[237.297215] Dynamic subtest vcs1: SUCCESS (0.021s)
[237.303478] Starting dynamic subtest: vecs0
[237.316725] Dynamic subtest vecs0: SUCCESS (0.019s)
[237.323602] Starting dynamic subtest: ccs0
[237.346956] Dynamic subtest ccs0: SUCCESS (0.030s)
[237.347972] Subtest preempt: SUCCESS (0.169s)
[239.011434] [035/131] (784s left) kms_flip (wf_vblank-ts-check-interruptible)
[239.109296] Starting subtest: wf_vblank-ts-check-interruptible
[239.111852] Starting dynamic subtest: A-eDP1
[247.991883] Dynamic subtest A-eDP1: SUCCESS (8.879s)
[248.001790] Starting dynamic subtest: B-eDP1
[256.935828] Dynamic subtest B-eDP1: SUCCESS (8.942s)
[256.945877] Starting dynamic subtest: C-eDP1
[265.860057] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[265.867180] Starting dynamic subtest: D-eDP1
[274.716373] Dynamic subtest D-eDP1: SUCCESS (8.855s)
[274.719529] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.607s)
[275.934526] [036/131] (747s left) gem_userptr_blits (unsync-overlap)
[275.988233] Subtest unsync-overlap: SKIP (0.000s)
[276.122804] [037/131] (747s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[276.218083] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[276.230066] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[276.298283] [038/131] (747s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[276.386838] Starting subtest: primary-yf-tiled-reflect-x-270
[276.388754] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[276.449940] [039/131] (747s left) kms_vrr (negative-basic)
[276.535873] Starting subtest: negative-basic
[276.538894] Starting dynamic subtest: pipe-A-eDP-1
[281.956168] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[282.258426] Subtest negative-basic: SUCCESS (5.721s)
[283.071381] [040/131] (740s left) perf_pmu (semaphore-wait)
[283.108174] Starting subtest: semaphore-wait
[283.109155] Starting dynamic subtest: rcs0
[283.625211] Dynamic subtest rcs0: SUCCESS (0.514s)
[283.635931] Starting dynamic subtest: bcs0
[284.138907] Dynamic subtest bcs0: SUCCESS (0.510s)
[284.149041] Starting dynamic subtest: vcs0
[284.652311] Dynamic subtest vcs0: SUCCESS (0.511s)
[284.661393] Starting dynamic subtest: vcs1
[285.166453] Dynamic subtest vcs1: SUCCESS (0.511s)
[285.178843] Starting dynamic subtest: vecs0
[285.680389] Dynamic subtest vecs0: SUCCESS (0.512s)
[285.690090] Starting dynamic subtest: ccs0
[286.196635] Dynamic subtest ccs0: SUCCESS (0.513s)
[286.197885] Subtest semaphore-wait: SUCCESS (3.086s)
[286.304446] [041/131] (737s left) kms_force_connector_basic (force-load-detect)
[286.372242] Starting subtest: force-load-detect
[286.373928] Subtest force-load-detect: SKIP (0.000s)
[286.487562] [042/131] (737s left) gem_ctx_engines (execute-allforone)
[286.543305] Starting subtest: execute-allforone
[286.559048] Subtest execute-allforone: SUCCESS (0.016s)
[287.984663] [043/131] (735s left) gem_exec_schedule (u-fairslice)
[288.047028] Starting subtest: u-fairslice
[288.047931] Starting dynamic subtest: rcs0
[290.068986] Dynamic subtest rcs0: SUCCESS (2.020s)
[290.078445] Starting dynamic subtest: bcs0
[292.094323] Dynamic subtest bcs0: SUCCESS (2.024s)
[292.101731] Starting dynamic subtest: vcs0
[294.113936] Dynamic subtest vcs0: SUCCESS (2.018s)
[294.121047] Starting dynamic subtest: vcs1
[296.129556] Dynamic subtest vcs1: SUCCESS (2.016s)
[296.136310] Starting dynamic subtest: vecs0
[298.150385] Dynamic subtest vecs0: SUCCESS (2.017s)
[298.165805] Starting dynamic subtest: ccs0
[300.168390] Dynamic subtest ccs0: SUCCESS (2.019s)
[300.169557] Subtest u-fairslice: SUCCESS (12.119s)
[300.459466] [044/131] (723s left) gem_exec_reloc (basic-cpu-gtt)
[300.516772] Subtest basic-cpu-gtt: SKIP (0.000s)
[300.591899] [045/131] (723s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[300.693596] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[305.175694] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.483s)
[306.298122] [046/131] (717s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[306.391768] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[306.394092] Starting dynamic subtest: pipe-A-default-mode
[306.678516] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[306.680350] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.285s)
[307.503989] [047/131] (716s left) gem_exec_gttfill (all-engines)
[307.553722] Starting subtest: all-engines
[330.489973] Subtest all-engines: SUCCESS (22.932s)
[330.668580] [048/131] (693s left) dmabuf_sync_file (export-before-signal)
[330.797729] Starting subtest: export-before-signal
[330.798736] Subtest export-before-signal: SUCCESS (0.001s)
[330.851141] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[330.853576] [049/131] (693s left) kms_addfb_basic (tile-pitch-mismatch)
[330.896239] Starting subtest: tile-pitch-mismatch
[330.898361] Subtest tile-pitch-mismatch: SKIP (0.000s)
[331.049814] [050/131] (692s left) kms_chamelium_frames (hdmi-crc-fast)
[331.416090] Subtest hdmi-crc-fast: SKIP (0.000s)
[332.209968] [051/131] (691s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[332.311858] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[333.312381] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.001s)
[333.451803] [052/131] (690s left) gem_pwrite (basic-exhaustion)
[333.509835] Subtest basic-exhaustion: SKIP (0.000s)
[333.570239] [053/131] (690s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[333.946614] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[334.744274] [054/131] (689s left) i915_drm_fdinfo (busy-hang)
[334.775670] Starting subtest: busy-hang
[334.776656] Starting dynamic subtest: rcs0
[334.803135] Dynamic subtest rcs0: SKIP (0.026s)
[334.812405] Starting dynamic subtest: bcs0
[334.814072] Dynamic subtest bcs0: SKIP (0.001s)
[334.821178] Starting dynamic subtest: vcs0
[334.822832] Dynamic subtest vcs0: SKIP (0.000s)
[334.829938] Starting dynamic subtest: vcs1
[334.831583] Dynamic subtest vcs1: SKIP (0.000s)
[334.838475] Starting dynamic subtest: vecs0
[334.840069] Dynamic subtest vecs0: SKIP (0.000s)
[334.846972] Starting dynamic subtest: ccs0
[334.848601] Dynamic subtest ccs0: SKIP (0.000s)
[334.850175] Subtest busy-hang: SKIP (0.031s)
[334.876557] [055/131] (689s left) gem_lmem_swapping (parallel-random)
[334.910409] Subtest parallel-random: SKIP (0.000s)
[334.951390] [056/131] (689s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[335.081421] Starting subtest: cursorB-vs-flipB-toggle
[335.083174] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[335.205995] [057/131] (689s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[335.296881] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[335.297828] Starting dynamic subtest: pipe-A-eDP-1
[335.728763] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.430s)
[335.739199] Starting dynamic subtest: pipe-B-eDP-1
[335.748021] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[335.755553] Starting dynamic subtest: pipe-C-eDP-1
[335.763721] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[335.770998] Starting dynamic subtest: pipe-D-eDP-1
[335.778625] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[335.779466] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.444s)
[338.051474] [058/131] (686s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[338.139049] Starting subtest: flip-primary-invalidate-overlay
[349.722663] Subtest flip-primary-invalidate-overlay: SUCCESS (11.583s)
[349.889707] [059/131] (674s left) kms_cdclk (mode-transition)
[349.987755] Starting subtest: mode-transition
[349.993718] Starting dynamic subtest: pipe-A-eDP-1
[350.274208] Dynamic subtest pipe-A-eDP-1: SKIP (0.285s)
[350.282245] Starting dynamic subtest: pipe-B-eDP-1
[350.284110] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[350.291363] Starting dynamic subtest: pipe-C-eDP-1
[350.293109] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[350.300211] Starting dynamic subtest: pipe-D-eDP-1
[350.301907] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[350.303653] Subtest mode-transition: SKIP (0.293s)
[351.075390] [060/131] (673s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[351.130515] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[351.234047] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[351.303482] [061/131] (673s left) gem_mmap_gtt (cpuset-big-copy)
[351.346019] Subtest cpuset-big-copy: SKIP (0.000s)
[351.402470] [062/131] (672s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[351.496100] Starting subtest: fbc-tiling-linear
[355.450052] Subtest fbc-tiling-linear: SUCCESS (3.955s)
[356.612647] [063/131] (667s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[356.723309] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[358.182547] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.457s)
[358.969541] [064/131] (665s left) gem_softpin (evict-snoop)
[359.035967] Starting subtest: evict-snoop
[359.037952] Subtest evict-snoop: SKIP (0.000s)
[359.165322] [065/131] (665s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[359.259532] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[359.261423] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[359.350701] [066/131] (665s left) kms_cursor_crc (cursor-sliding-max-size)
[359.658313] Starting subtest: cursor-sliding-max-size
[359.660912] Subtest cursor-sliding-max-size: SKIP (0.000s)
[359.797245] [067/131] (664s left) kms_psr (fbc-psr2-primary-render)
[359.886205] Starting subtest: fbc-psr2-primary-render
[359.887225] Starting dynamic subtest: eDP-1
[359.889122] Dynamic subtest eDP-1: SKIP (0.000s)
[359.891025] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[359.952711] [068/131] (664s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[360.005377] Starting subtest: x-tiled-to-vebox-y-tiled
[360.007411] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[360.183884] [069/131] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[360.271306] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[360.272993] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[360.356476] [070/131] (664s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[360.454261] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[361.090402] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.636s)
[361.244452] [071/131] (663s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[361.347763] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[361.349605] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[361.440278] [072/131] (663s left) gem_exec_whisper (basic-fds-forked)
[361.506636] Starting subtest: basic-fds-forked
[385.104240] Subtest basic-fds-forked: SUCCESS (23.593s)
[385.284135] [073/131] (639s left) kms_addfb_basic (unused-pitches)
[385.329452] Starting subtest: unused-pitches
[385.330366] Subtest unused-pitches: SUCCESS (0.000s)
[385.478746] [074/131] (639s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[385.574382] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[390.093894] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.519s)
[391.280632] [075/131] (633s left) gem_pipe_control_store_loop (fresh-buffer)
[391.341686] Starting subtest: fresh-buffer
[393.496580] Subtest fresh-buffer: SUCCESS (2.152s)
[393.626572] [076/131] (631s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[393.718551] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[400.272894] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (6.553s)
[400.402167] [077/131] (624s left) gem_exec_suspend (basic-s4-devices)
[400.473422] Starting subtest: basic-S4-devices
[400.474478] Starting dynamic subtest: smem
[411.927981] Dynamic subtest smem: SUCCESS (11.450s)
[411.930065] Subtest basic-S4-devices: SUCCESS (11.452s)
[417.118619] [078/131] (612s left) i915_pm_freq_api (freq-basic-api)
[417.181114] Starting subtest: freq-basic-api
[417.182178] Starting dynamic subtest: gt0
[417.194064] Dynamic subtest gt0: SUCCESS (0.013s)
[417.205216] Starting dynamic subtest: gt1
[417.206157] Dynamic subtest gt1: SUCCESS (0.006s)
[417.207039] Subtest freq-basic-api: SUCCESS (0.021s)
[417.317713] [079/131] (612s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[417.699540] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[418.492597] [080/131] (611s left) kms_pm_backlight (bad-brightness)
[418.588475] Starting subtest: bad-brightness
[418.649030] Starting dynamic subtest: eDP-1
[418.957339] Dynamic subtest eDP-1: SUCCESS (0.308s)
[418.958735] Subtest bad-brightness: SUCCESS (0.370s)
[419.751389] [081/131] (610s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[419.842746] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[419.843616] Starting dynamic subtest: pipe-A-eDP-1
[419.851837] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[419.860283] Starting dynamic subtest: pipe-B-eDP-1
[419.868629] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[419.876983] Starting dynamic subtest: pipe-C-eDP-1
[419.885027] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[419.893343] Starting dynamic subtest: pipe-D-eDP-1
[419.901977] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[419.903662] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[422.022928] [082/131] (608s left) syncobj_basic (bad-destroy)
[422.068291] Starting subtest: bad-destroy
[422.069546] Subtest bad-destroy: SUCCESS (0.000s)
[422.159753] [083/131] (607s left) kms_setmode (invalid-clone-single-crtc)
[422.216409] Starting subtest: invalid-clone-single-crtc
[422.219221] Subtest invalid-clone-single-crtc: SKIP (0.001s)
[422.325659] [084/131] (607s left) kms_cursor_crc (cursor-dpms)
[422.448848] Starting subtest: cursor-dpms
[422.449785] Starting dynamic subtest: pipe-A-eDP-1
[425.404099] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.954s)
[425.418614] Starting dynamic subtest: pipe-D-eDP-1
[428.980346] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.575s)
[428.981413] Subtest cursor-dpms: SUCCESS (6.531s)
[429.813830] [085/131] (600s left) syncobj_timeline (signal-point-0)
[429.869196] Starting subtest: signal-point-0
[429.870116] Subtest signal-point-0: SUCCESS (0.000s)
[429.978853] [086/131] (600s left) syncobj_timeline (single-wait-all-available-submitted)
[430.036229] Starting subtest: single-wait-all-available-submitted
[430.037156] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[430.133115] [087/131] (600s left) gem_exec_params (invalid-fence-in)
[430.188384] Starting subtest: invalid-fence-in
[430.189330] Subtest invalid-fence-in: SUCCESS (0.000s)
[430.293557] [088/131] (599s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[430.386499] Starting subtest: fbc-rgb565-draw-mmap-cpu
[434.498734] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.113s)
[435.623961] [089/131] (594s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[435.729402] Starting subtest: 4-tiled-32bpp-rotate-270
[435.748928] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[435.871080] [090/131] (594s left) syncobj_wait (invalid-signal-bad-pad)
[435.927169] Starting subtest: invalid-signal-bad-pad
[435.928026] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[436.034539] [091/131] (594s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[436.129384] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[436.865518] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.736s)
[437.075949] [092/131] (593s left) gem_spin_batch (legacy)
[437.143835] Starting subtest: legacy
[437.144934] Starting dynamic subtest: default
[440.384037] Dynamic subtest default: SUCCESS (3.237s)
[440.394630] Starting dynamic subtest: render
[443.622080] Dynamic subtest render: SUCCESS (3.233s)
[443.633424] Starting dynamic subtest: bsd
[446.858364] Dynamic subtest bsd: SUCCESS (3.233s)
[446.867335] Starting dynamic subtest: bsd1
[450.096724] Dynamic subtest bsd1: SUCCESS (3.237s)
[450.105641] Starting dynamic subtest: bsd2
[453.333880] Dynamic subtest bsd2: SUCCESS (3.233s)
[453.344191] Starting dynamic subtest: blt
[456.570764] Dynamic subtest blt: SUCCESS (3.235s)
[456.580031] Starting dynamic subtest: vebox
[459.809443] Dynamic subtest vebox: SUCCESS (3.236s)
[459.810543] Subtest legacy: SUCCESS (22.662s)
[459.985519] [093/131] (570s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[460.082940] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[460.085078] Starting dynamic subtest: pipe-A-default-mode
[460.369908] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[460.371818] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.285s)
[461.240510] [094/131] (569s left) dmabuf_sync_file (export-wait-after-attach)
[461.274062] Starting subtest: export-wait-after-attach
[461.275069] Subtest export-wait-after-attach: SUCCESS (0.000s)
[461.325101] [095/131] (569s left) kms_flip (2x-flip-vs-modeset)
[461.417410] Starting subtest: 2x-flip-vs-modeset
[461.428690] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[461.542198] [096/131] (568s left) kms_prop_blob (basic)
[461.596938] Starting subtest: basic
[461.597914] Subtest basic: SUCCESS (0.000s)
[461.713090] [097/131] (568s left) gem_userptr_blits (dmabuf-sync)
[461.775707] Starting subtest: dmabuf-sync
[461.779275] Subtest dmabuf-sync: SKIP (0.002s)
[461.911210] [098/131] (568s left) gem_close_race (basic-threads)
[461.969434] Starting subtest: basic-threads
[463.377933] Subtest basic-threads: SUCCESS (1.408s)
[463.553384] [099/131] (567s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[463.645745] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[463.647448] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[463.726597] [100/131] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[463.827201] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[471.259588] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.433s)
[471.400424] [101/131] (559s left) gem_eio (wait-wedge-1us)
[471.589599] Starting subtest: wait-wedge-1us
[472.977205] Subtest wait-wedge-1us: SUCCESS (1.387s)
[473.131163] [102/131] (557s left) syncobj_wait (multi-wait-submitted)
[473.184415] Starting subtest: multi-wait-submitted
[473.291620] Subtest multi-wait-submitted: SUCCESS (0.106s)
[473.358220] [103/131] (557s left) gem_create (create-ext-placement-each)
[473.514286] Starting subtest: create-ext-placement-each
[473.515276] Subtest create-ext-placement-each: SUCCESS (0.000s)
[473.602905] [104/131] (557s left) prime_vgem (sync)
[473.658509] Starting subtest: sync
[473.659457] Starting dynamic subtest: rcs0
[473.719719] Dynamic subtest rcs0: SUCCESS (0.061s)
[473.728563] Starting dynamic subtest: bcs0
[473.814056] Dynamic subtest bcs0: SUCCESS (0.094s)
[473.822810] Starting dynamic subtest: vcs0
[473.861834] Dynamic subtest vcs0: SUCCESS (0.047s)
[473.870482] Starting dynamic subtest: vcs1
[473.910965] Dynamic subtest vcs1: SUCCESS (0.048s)
[473.919655] Starting dynamic subtest: vecs0
[473.956225] Dynamic subtest vecs0: SUCCESS (0.045s)
[473.964759] Starting dynamic subtest: ccs0
[474.001060] Dynamic subtest ccs0: SUCCESS (0.044s)
[474.002128] Subtest sync: SUCCESS (0.343s)
[474.115501] [105/131] (556s left) kms_pm_rpm (dpms-lpsp)
[476.038100] Starting subtest: dpms-lpsp
[476.348876] Subtest dpms-lpsp: SUCCESS (0.311s)
[476.431357] [106/131] (554s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[481.501275] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[481.503066] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[482.340854] [107/131] (548s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[482.434190] Starting subtest: yf-tiled-32bpp-rotate-180
[482.436025] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[482.512413] [108/131] (548s left) gem_exec_balancer (parallel-out-fence)
[482.764329] Starting subtest: parallel-out-fence
[483.903907] Subtest parallel-out-fence: SUCCESS (1.141s)
[484.029537] [109/131] (546s left) gem_ctx_sseu (invalid-args)
[484.084921] Subtest invalid-args: SKIP (0.000s)
[484.157648] [110/131] (546s left) kms_cursor_crc (cursor-onscreen-128x42)
[484.381164] Starting subtest: cursor-onscreen-128x42
[484.420909] Subtest cursor-onscreen-128x42: SKIP (0.037s)
[484.646517] [111/131] (546s left) gem_exec_nop (basic-parallel)
[484.706532] Starting subtest: basic-parallel
[500.886734] Subtest basic-parallel: SUCCESS (16.182s)
[501.118567] [112/131] (529s left) kms_rotation_crc (cursor-rotation-180)
[501.224947] Starting subtest: cursor-rotation-180
[502.713448] Subtest cursor-rotation-180: SUCCESS (1.488s)
[503.912144] [113/131] (527s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[504.007215] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[504.008894] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[504.105388] [114/131] (526s left) gem_softpin (evict-prime)
[504.168511] Starting subtest: evict-prime
[504.169637] Starting dynamic subtest: rcs0
[505.340709] Dynamic subtest rcs0: SUCCESS (1.171s)
[505.354773] Starting dynamic subtest: bcs0
[506.486231] Dynamic subtest bcs0: SUCCESS (1.143s)
[506.498647] Starting dynamic subtest: vcs0
[507.963117] Dynamic subtest vcs0: SUCCESS (1.473s)
[507.979406] Starting dynamic subtest: vcs1
[509.953531] Dynamic subtest vcs1: SUCCESS (1.988s)
[509.965583] Starting dynamic subtest: vecs0
[511.895039] Dynamic subtest vecs0: SUCCESS (1.940s)
[511.906797] Starting dynamic subtest: ccs0
[513.017398] Dynamic subtest ccs0: SUCCESS (1.123s)
[513.027149] Starting dynamic subtest: all
[514.926088] Dynamic subtest all: SUCCESS (1.905s)
[514.927535] Subtest evict-prime: SUCCESS (10.756s)
[515.000514] [115/131] (516s left) kms_psr (psr2-primary-blt)
[515.115967] Starting subtest: psr2-primary-blt
[515.116975] Starting dynamic subtest: eDP-1
[516.818890] Dynamic subtest eDP-1: SUCCESS (1.702s)
[516.820690] Subtest psr2-primary-blt: SUCCESS (1.703s)
[517.675040] [116/131] (513s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[517.774525] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[517.776287] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[517.866414] [117/131] (513s left) kms_cursor_edge_walk (256x256-top-bottom)
[517.955433] Starting subtest: 256x256-top-bottom
[517.956292] Starting dynamic subtest: pipe-A-eDP-1
[521.449975] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[521.469417] Starting dynamic subtest: pipe-D-eDP-1
[524.582365] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[524.583295] Subtest 256x256-top-bottom: SUCCESS (6.627s)
[525.377133] [118/131] (505s left) gem_exec_endless (dispatch)
[525.438895] Starting subtest: dispatch
[525.440062] Starting dynamic subtest: rcs0
[525.446379] Dynamic subtest rcs0: SUCCESS (0.007s)
[525.457399] Starting dynamic subtest: bcs0
[525.459166] Dynamic subtest bcs0: SUCCESS (0.004s)
[525.468135] Starting dynamic subtest: vcs0
[525.469971] Dynamic subtest vcs0: SUCCESS (0.005s)
[525.479948] Starting dynamic subtest: vcs1
[525.481969] Dynamic subtest vcs1: SUCCESS (0.005s)
[525.491468] Starting dynamic subtest: vecs0
[525.493369] Dynamic subtest vecs0: SUCCESS (0.005s)
[525.501617] Starting dynamic subtest: ccs0
[525.503461] Dynamic subtest ccs0: SUCCESS (0.004s)
[525.504422] Subtest dispatch: SUCCESS (0.034s)
[526.965491] [119/131] (504s left) kms_vblank (query-forked)
[527.058737] Starting subtest: query-forked
[527.059619] Starting dynamic subtest: pipe-A-eDP-1
[528.868047] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[528.879090] Starting dynamic subtest: pipe-D-eDP-1
[531.388309] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.519s)
[531.389448] Subtest query-forked: SUCCESS (4.329s)
[532.234799] [120/131] (499s left) gem_exec_schedule (noreorder-priority)
[532.407584] Starting subtest: noreorder-priority
[532.408540] Starting dynamic subtest: rcs0
[533.581644] Dynamic subtest rcs0: SUCCESS (1.174s)
[533.594688] Starting dynamic subtest: vcs0
[534.966208] Dynamic subtest vcs0: SUCCESS (1.379s)
[534.978527] Starting dynamic subtest: vcs1
[536.903041] Dynamic subtest vcs1: SUCCESS (1.935s)
[536.914619] Starting dynamic subtest: vecs0
[538.885449] Dynamic subtest vecs0: SUCCESS (1.980s)
[538.897493] Starting dynamic subtest: ccs0
[540.059766] Dynamic subtest ccs0: SUCCESS (1.173s)
[540.061039] Subtest noreorder-priority: SUCCESS (7.652s)
[540.235861] [121/131] (491s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[540.340357] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[540.342068] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[540.445691] [122/131] (490s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[540.543563] Starting subtest: plane-use-after-nonblocking-unbind
[540.544597] Starting dynamic subtest: pipe-A-eDP-1
[540.611669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.068s)
[540.923079] Starting dynamic subtest: pipe-B-eDP-1
[541.754233] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.839s)
[542.050568] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.507s)
[542.915904] [123/131] (488s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[543.027753] Starting subtest: flip-vs-cursor-varying-size
[551.253088] Subtest flip-vs-cursor-varying-size: SUCCESS (8.224s)
[552.052268] [124/131] (479s left) gem_reg_read (timestamp-monotonic)
[552.098347] Starting subtest: timestamp-monotonic
[556.566768] Subtest timestamp-monotonic: SUCCESS (4.466s)
[556.632902] [125/131] (474s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[556.721776] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[556.722773] Starting dynamic subtest: pipe-A-eDP-1
[556.745913] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[556.756245] Starting dynamic subtest: pipe-B-eDP-1
[556.778031] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[556.786611] Starting dynamic subtest: pipe-C-eDP-1
[556.807719] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[556.815549] Starting dynamic subtest: pipe-D-eDP-1
[556.835814] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[556.837377] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[558.932586] [126/131] (472s left) kms_psr (psr2-sprite-mmap-gtt)
[559.016380] Starting subtest: psr2-sprite-mmap-gtt
[559.017303] Starting dynamic subtest: eDP-1
[560.422078] Dynamic subtest eDP-1: SKIP (1.403s)
[560.424707] Subtest psr2-sprite-mmap-gtt: SKIP (1.404s)
[560.579637] [127/131] (470s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[560.673398] Starting subtest: fbcpsr-1p-rte
[567.632643] Subtest fbcpsr-1p-rte: SUCCESS (6.960s)
[567.759984] [128/131] (463s left) i915_hangman (engine-engine-error)
[567.816676] Starting subtest: engine-engine-error
[567.817486] Starting dynamic subtest: rcs0
[568.884406] Dynamic subtest rcs0: SUCCESS (1.066s)
[568.898773] Starting dynamic subtest: bcs0
[570.870905] Dynamic subtest bcs0: SUCCESS (1.982s)
[570.882308] Starting dynamic subtest: vcs0
[572.853657] Dynamic subtest vcs0: SUCCESS (1.981s)
[572.863645] Starting dynamic subtest: vcs1
[574.901119] Dynamic subtest vcs1: SUCCESS (2.044s)
[574.912758] Starting dynamic subtest: vecs0
[576.886438] Dynamic subtest vecs0: SUCCESS (1.983s)
[576.902241] Starting dynamic subtest: ccs0
[578.870058] Dynamic subtest ccs0: SUCCESS (1.981s)
[578.871620] Subtest engine-engine-error: SUCCESS (11.051s)
[578.946603] [129/131] (452s left) gem_ctx_param (set-priority-invalid-size)
[579.005736] Starting subtest: set-priority-invalid-size
[579.006776] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[579.074990] [130/131] (452s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[579.123048] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[579.225750] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[579.299990] [131/131] (452s left) perf (gen12-invalid-class-instance)
[579.409816] Starting subtest: gen12-invalid-class-instance
[579.422456] Subtest gen12-invalid-class-instance: SUCCESS (0.013s)
[579.460495] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: api_intel_bb
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: drm_read
results: parsing output: 5/ for test: kms_draw_crc
results: parsing output: 6/ for test: gem_exec_flush
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_async_flips
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_readwrite
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: i915_suspend
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: kms_plane_multiple
results: parsing output: 24/ for test: kms_pipe_crc_basic
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: gen9_exec_parse
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: i915_pm_rpm
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: gem_softpin
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: sysfs_preempt_timeout
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_vrr
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_force_connector_basic
results: parsing output: 41/ for test: gem_ctx_engines
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: gem_exec_gttfill
results: parsing output: 47/ for test: dmabuf_sync_file
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_pwrite
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: i915_drm_fdinfo
results: parsing output: 54/ for test: gem_lmem_swapping
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_psr_stress_test
results: parsing output: 58/ for test: kms_cdclk
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_whisper
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_pipe_control_store_loop
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_suspend
results: parsing output: 77/ for test: i915_pm_freq_api
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: syncobj_basic
results: parsing output: 82/ for test: kms_setmode
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: dmabuf_sync_file
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: gem_userptr_blits
results: parsing output: 97/ for test: gem_close_race
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: gem_create
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: kms_pm_rpm
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: gem_ctx_sseu
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_exec_nop
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_cursor_edge_walk
results: parsing output: 117/ for test: gem_exec_endless
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_atomic_transition
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: gem_reg_read
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: i915_hangman
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: perf
Done.