[70.479545] Initializing watchdogs
[70.479628]   /dev/watchdog0
[70.510929] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[70.526185] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[70.531200] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.534172] [001/132] (960s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[72.035265] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[72.040933] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.000s)
[72.167342] [002/132] (958s left) i915_pm_rpm (gem-idle)
[76.018645] Starting subtest: gem-idle
[82.006039] Subtest gem-idle: SUCCESS (5.982s)
[82.311067] [003/132] (948s left) vgem_basic (bad-handle)
[82.423582] Starting subtest: bad-handle
[82.425217] Subtest bad-handle: SUCCESS (0.000s)
[82.523939] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[82.526619] [004/132] (948s left) kms_addfb_basic (bad-pitch-0)
[82.573126] Starting subtest: bad-pitch-0
[82.574743] Subtest bad-pitch-0: SUCCESS (0.000s)
[84.166671] [005/132] (947s left) kms_atomic_transition (modeset-transition)
[85.660124] Starting subtest: modeset-transition
[85.661610] Starting dynamic subtest: 1x-outputs
[87.661177] Dynamic subtest 1x-outputs: SUCCESS (1.997s)
[87.663172] Subtest modeset-transition: SUCCESS (1.997s)
[87.842336] [006/132] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[89.341622] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[89.345059] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[89.485993] [007/132] (942s left) gem_exec_fence (invalid-fence-array)
[89.950111] Starting subtest: invalid-fence-array
[89.953602] Subtest invalid-fence-array: SUCCESS (0.003s)
[90.349201] [008/132] (941s left) gem_busy (extended)
[90.600603] Starting subtest: extended
[90.602602] Starting dynamic subtest: rcs0
[90.675929] Dynamic subtest rcs0: SUCCESS (0.078s)
[90.688438] Starting dynamic subtest: bcs0
[90.719816] Dynamic subtest bcs0: SUCCESS (0.043s)
[90.737145] Starting dynamic subtest: vcs0
[90.764289] Dynamic subtest vcs0: SUCCESS (0.044s)
[90.777688] Starting dynamic subtest: vcs1
[90.809346] Dynamic subtest vcs1: SUCCESS (0.045s)
[90.823104] Starting dynamic subtest: vecs0
[90.853130] Dynamic subtest vecs0: SUCCESS (0.042s)
[90.855665] Subtest extended: SUCCESS (0.255s)
[91.166318] [009/132] (940s left) gem_softpin (noreloc-s3)
[91.219873] Starting subtest: noreloc-S3
[112.410488] Subtest noreloc-S3: SUCCESS (10.612s)
[119.587936] [010/132] (919s left) kms_chamelium_hpd (hdmi-hpd)
[121.119945] Subtest hdmi-hpd: SKIP (0.000s)
[121.230137] [011/132] (917s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[122.741538] Starting subtest: y-tiled-8bpp-rotate-90
[122.850654] Subtest y-tiled-8bpp-rotate-90: SKIP (0.107s)
[122.998847] [012/132] (915s left) perf (invalid-create-userspace-config)
[123.138122] Starting subtest: invalid-create-userspace-config
[123.139718] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[123.212920] [013/132] (915s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[124.697070] Starting subtest: primary-yf-tiled-reflect-x-180
[124.800207] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.102s)
[125.010707] [014/132] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[126.505695] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[126.508657] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[126.675526] [015/132] (912s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[128.170269] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[128.173287] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[128.338330] [016/132] (911s left) prime_self_import (basic-with_one_bo_two_files)
[128.385457] Starting subtest: basic-with_one_bo_two_files
[128.390590] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[128.581462] [017/132] (910s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[130.070423] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[130.143721] [018/132] (909s left) gem_wait (await)
[130.206649] Starting subtest: await
[130.208413] Starting dynamic subtest: all-engines
[131.317107] Dynamic subtest all-engines: SUCCESS (1.110s)
[131.330431] Starting dynamic subtest: rcs0
[132.378187] Dynamic subtest rcs0: SUCCESS (1.060s)
[132.391658] Starting dynamic subtest: bcs0
[133.437133] Dynamic subtest bcs0: SUCCESS (1.058s)
[133.454810] Starting dynamic subtest: vcs0
[134.496224] Dynamic subtest vcs0: SUCCESS (1.059s)
[134.509543] Starting dynamic subtest: vcs1
[135.555259] Dynamic subtest vcs1: SUCCESS (1.058s)
[135.568718] Starting dynamic subtest: vecs0
[136.613203] Dynamic subtest vecs0: SUCCESS (1.057s)
[136.615053] Subtest await: SUCCESS (6.406s)
[136.903302] [019/132] (902s left) kms_flip (2x-plain-flip-fb-recreate)
[138.390914] Starting subtest: 2x-plain-flip-fb-recreate
[138.408259] Subtest 2x-plain-flip-fb-recreate: SKIP (0.018s)
[138.564285] [020/132] (901s left) syncobj_timeline (single-wait-all-available-signaled)
[138.613100] Starting subtest: single-wait-all-available-signaled
[138.614416] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[138.717747] [021/132] (901s left) kms_flip (wf_vblank-ts-check)
[140.201600] Starting subtest: wf_vblank-ts-check
[140.207740] Starting dynamic subtest: A-HDMI-A4
[148.245267] Dynamic subtest A-HDMI-A4: SUCCESS (8.037s)
[148.257927] Starting dynamic subtest: B-HDMI-A4
[156.372715] Dynamic subtest B-HDMI-A4: SUCCESS (8.127s)
[156.384335] Starting dynamic subtest: C-HDMI-A4
[164.333636] Dynamic subtest C-HDMI-A4: SUCCESS (7.960s)
[164.345844] Starting dynamic subtest: D-HDMI-A4
[172.301437] Dynamic subtest D-HDMI-A4: SUCCESS (7.967s)
[172.302926] Subtest wf_vblank-ts-check: SUCCESS (32.101s)
[172.506792] [022/132] (867s left) kms_vblank (ts-continuation-dpms-suspend)
[173.991723] Starting subtest: ts-continuation-dpms-suspend
[173.993248] Starting dynamic subtest: pipe-A-HDMI-A-4
[194.588289] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.463s)
[194.602736] Starting dynamic subtest: pipe-D-HDMI-A-4
[216.574230] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (10.060s)
[216.575766] Subtest ts-continuation-dpms-suspend: SUCCESS (20.529s)
[221.758480] [023/132] (823s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[223.543691] Starting subtest: cursor-rapid-movement-512x170
[223.546383] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[223.751989] [024/132] (821s left) i915_hangman (engine-engine-hang)
[223.813614] Starting subtest: engine-engine-hang
[223.815036] Starting dynamic subtest: rcs0
[224.515008] Dynamic subtest rcs0: SUCCESS (0.701s)
[224.531579] Starting dynamic subtest: bcs0
[225.181770] Dynamic subtest bcs0: SUCCESS (0.666s)
[225.192813] Starting dynamic subtest: vcs0
[225.843859] Dynamic subtest vcs0: SUCCESS (0.662s)
[225.857287] Starting dynamic subtest: vcs1
[226.513809] Dynamic subtest vcs1: SUCCESS (0.670s)
[226.525427] Starting dynamic subtest: vecs0
[227.185892] Dynamic subtest vecs0: SUCCESS (0.672s)
[227.187623] Subtest engine-engine-hang: SUCCESS (3.372s)
[227.361174] [025/132] (817s left) gem_exec_schedule (preempt-queue-contexts-chain)
[227.427814] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[227.782174] [026/132] (817s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[229.266654] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[229.268309] Starting dynamic subtest: pipe-A-HDMI-A-4
[229.282733] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[229.293879] Starting dynamic subtest: pipe-B-HDMI-A-4
[229.306994] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[229.317709] Starting dynamic subtest: pipe-C-HDMI-A-4
[229.330842] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[229.341696] Starting dynamic subtest: pipe-D-HDMI-A-4
[229.355629] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[229.358450] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[229.506361] [027/132] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[231.026351] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[234.042526] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (3.017s)
[234.214098] [028/132] (811s left) i915_selftest (live)
[235.243526] Starting subtest: live
[235.245083] Starting dynamic subtest: sanitycheck
[236.587819] Dynamic subtest sanitycheck: SUCCESS (1.344s)
[236.597875] Starting dynamic subtest: uncore
[237.926240] Dynamic subtest uncore: SUCCESS (1.338s)
[237.936008] Starting dynamic subtest: workarounds
[241.156679] Dynamic subtest workarounds: SUCCESS (3.229s)
[241.166463] Starting dynamic subtest: gt_engines
[243.029756] Dynamic subtest gt_engines: SUCCESS (1.872s)
[243.039492] Starting dynamic subtest: gt_timelines
[309.004577] Dynamic subtest gt_timelines: SUCCESS (65.968s)
[309.014604] Starting dynamic subtest: gt_contexts
[310.338309] Dynamic subtest gt_contexts: SUCCESS (1.333s)
[310.348754] Starting dynamic subtest: gt_lrc
[316.314868] Dynamic subtest gt_lrc: SUCCESS (5.975s)
[316.324925] Starting dynamic subtest: gt_mocs
[318.606627] Dynamic subtest gt_mocs: SUCCESS (2.291s)
[318.617122] Starting dynamic subtest: gt_pm
[322.577525] Dynamic subtest gt_pm: SUCCESS (3.971s)
[322.587234] Starting dynamic subtest: gt_heartbeat
[323.909405] Dynamic subtest gt_heartbeat: SUCCESS (1.331s)
[323.920036] Starting dynamic subtest: gt_tlb
[337.698780] Dynamic subtest gt_tlb: SUCCESS (13.789s)
[337.708454] Starting dynamic subtest: requests
[348.447525] Dynamic subtest requests: SUCCESS (10.748s)
[348.457404] Starting dynamic subtest: migrate
[353.064397] Dynamic subtest migrate: SUCCESS (4.616s)
[353.074502] Starting dynamic subtest: active
[354.387449] Dynamic subtest active: SUCCESS (1.322s)
[354.398634] Starting dynamic subtest: objects
[356.609351] Dynamic subtest objects: SUCCESS (2.221s)
[356.620185] Starting dynamic subtest: mman
[360.043397] Dynamic subtest mman: SUCCESS (3.433s)
[360.052987] Starting dynamic subtest: dmabuf
[361.430625] Dynamic subtest dmabuf: SUCCESS (1.386s)
[361.440731] Starting dynamic subtest: vma
[362.752576] Dynamic subtest vma: SUCCESS (1.321s)
[362.762861] Starting dynamic subtest: coherency
[372.693369] Dynamic subtest coherency: SUCCESS (9.940s)
[372.704505] Starting dynamic subtest: gtt
[381.668949] Dynamic subtest gtt: SUCCESS (8.974s)
[381.678931] Starting dynamic subtest: gem
[383.130531] Dynamic subtest gem: SUCCESS (1.461s)
[383.140849] Starting dynamic subtest: evict
[394.536027] Dynamic subtest evict: SUCCESS (11.404s)
[394.546039] Starting dynamic subtest: hugepages
[411.803842] Dynamic subtest hugepages: SUCCESS (17.266s)
[411.814236] Starting dynamic subtest: gem_contexts
[439.387191] Dynamic subtest gem_contexts: SUCCESS (27.583s)
[439.397317] Starting dynamic subtest: client
[440.784703] Dynamic subtest client: SUCCESS (1.393s)
[440.795110] Starting dynamic subtest: gem_migrate
[443.296683] Dynamic subtest gem_migrate: SUCCESS (2.511s)
[443.306752] Starting dynamic subtest: reset
[444.660551] Dynamic subtest reset: SUCCESS (1.363s)
[444.671807] Starting dynamic subtest: memory_region
[447.611608] Dynamic subtest memory_region: SUCCESS (2.950s)
[447.621687] Starting dynamic subtest: hangcheck
[475.424582] Dynamic subtest hangcheck: SUCCESS (27.814s)
[475.435368] Starting dynamic subtest: execlists
[476.752700] Dynamic subtest execlists: SUCCESS (1.327s)
[476.762867] Starting dynamic subtest: ring_submission
[478.063491] Dynamic subtest ring_submission: SUCCESS (1.310s)
[478.074004] Starting dynamic subtest: perf
[479.477679] Dynamic subtest perf: SUCCESS (1.413s)
[479.488436] Starting dynamic subtest: slpc
[485.326520] Dynamic subtest slpc: SUCCESS (5.848s)
[485.336909] Starting dynamic subtest: guc
[488.724537] Dynamic subtest guc: SUCCESS (3.397s)
[488.734452] Starting dynamic subtest: guc_multi_lrc
[490.053749] Dynamic subtest guc_multi_lrc: SUCCESS (1.328s)
[490.064198] Starting dynamic subtest: guc_hang
[492.149698] Dynamic subtest guc_hang: SUCCESS (2.095s)
[492.159874] Starting dynamic subtest: late_gt_pm
[493.492400] Dynamic subtest late_gt_pm: SUCCESS (1.342s)
[493.493910] Subtest live: SUCCESS (258.240s)
[493.536147] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[493.537281] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[493.540259] [029/132] (551s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[498.237923] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[498.240839] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[498.484172] [FACT kms_plane (pixel-format-yf-tiled-ccs-modifier)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[498.487745] [FACT kms_plane (pixel-format-yf-tiled-ccs-modifier)] new: kernel.kmod_is_loaded.i915: true
[498.495005] [030/132] (547s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[499.982135] Starting subtest: fb-8bpc-vs-panel-8bpc
[499.987128] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.001s)
[500.088748] [031/132] (545s left) gem_exec_flush (basic-wb-set-default)
[500.150001] Subtest basic-wb-set-default: SKIP (0.000s)
[500.256754] [032/132] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[501.748512] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[501.751017] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[501.907178] [033/132] (543s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[503.395793] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[503.399045] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[503.596202] [034/132] (542s left) kms_cursor_crc (cursor-onscreen-32x10)
[505.204106] Starting subtest: cursor-onscreen-32x10
[505.255935] Subtest cursor-onscreen-32x10: SKIP (0.048s)
[505.719574] [035/132] (540s left) gem_exec_balancer (bonded-false-hang)
[506.089015] Starting subtest: bonded-false-hang
[506.092121] Subtest bonded-false-hang: SKIP (0.000s)
[506.207677] [036/132] (539s left) prime_mmap (test_reprime)
[506.256003] Starting subtest: test_reprime
[506.257633] Starting dynamic subtest: test_reprime-smem
[506.318835] Dynamic subtest test_reprime-smem: SUCCESS (0.062s)
[506.329948] Starting dynamic subtest: test_reprime-lmem0
[506.383485] Dynamic subtest test_reprime-lmem0: SUCCESS (0.063s)
[506.385099] Subtest test_reprime: SUCCESS (0.128s)
[506.535573] [037/132] (539s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[508.019020] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[508.022117] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[508.155749] [038/132] (538s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[509.699119] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[509.809615] [039/132] (536s left) gen9_exec_parse (unaligned-jump)
[509.864323] Subtest unaligned-jump: SKIP (0.000s)
[509.938754] [040/132] (536s left) gem_ctx_persistence (legacy-engines-mixed-process)
[509.992839] Starting subtest: legacy-engines-mixed-process
[509.994558] Starting dynamic subtest: render
[511.521313] Dynamic subtest render: SUCCESS (1.530s)
[511.535409] Starting dynamic subtest: bsd1
[513.503358] Dynamic subtest bsd1: SUCCESS (1.980s)
[513.517867] Starting dynamic subtest: bsd2
[515.485777] Dynamic subtest bsd2: SUCCESS (1.980s)
[515.500468] Starting dynamic subtest: blt
[517.467687] Dynamic subtest blt: SUCCESS (1.979s)
[517.482197] Starting dynamic subtest: vebox
[519.529016] Dynamic subtest vebox: SUCCESS (2.059s)
[519.531016] Subtest legacy-engines-mixed-process: SUCCESS (9.540s)
[519.646764] [041/132] (526s left) prime_vgem (basic-blt)
[519.728616] Starting subtest: basic-blt
[519.776275] Subtest basic-blt: SUCCESS (0.048s)
[519.996793] [042/132] (526s left) gen9_exec_parse (bb-oversize)
[520.048046] Subtest bb-oversize: SKIP (0.000s)
[520.123706] [043/132] (526s left) perf (mi-rpc)
[520.260330] Starting subtest: mi-rpc
[520.263238] Subtest mi-rpc: SKIP (0.000s)
[520.342537] [044/132] (526s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[521.831330] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[521.835124] Starting dynamic subtest: pipe-A-HDMI-A-4
[521.848514] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[521.860357] Starting dynamic subtest: pipe-B-HDMI-A-4
[521.873925] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[521.885617] Starting dynamic subtest: pipe-C-HDMI-A-4
[521.901754] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[521.913327] Starting dynamic subtest: pipe-D-HDMI-A-4
[521.927793] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[521.930758] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[522.071597] [045/132] (524s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[522.144094] Subtest untiled-to-tiled: SKIP (0.000s)
[522.235334] [046/132] (524s left) gem_mmap_wc (bad-object)
[522.286069] Subtest bad-object: SKIP (0.000s)
[522.371847] [047/132] (524s left) syncobj_timeline (multi-wait-all-signaled)
[522.419403] Starting subtest: multi-wait-all-signaled
[522.421064] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[522.547111] [048/132] (524s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[524.035114] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[524.118061] [049/132] (522s left) kms_big_fb (linear-64bpp-rotate-0)
[525.624563] Starting subtest: linear-64bpp-rotate-0
[528.124487] Subtest linear-64bpp-rotate-0: SUCCESS (2.497s)
[528.329339] [050/132] (518s left) kms_joiner (basic-big-joiner)
[529.818007] Starting subtest: basic-big-joiner
[529.821022] Subtest basic-big-joiner: SKIP (0.000s)
[529.935236] [051/132] (517s left) api_intel_bb (intel-bb-blit-none)
[530.028074] Starting subtest: intel-bb-blit-none
[530.689976] Subtest intel-bb-blit-none: SUCCESS (0.663s)
[530.848785] [052/132] (516s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[532.352998] Starting subtest: 4-tiled-8bpp-rotate-270
[532.356609] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[532.555487] [053/132] (514s left) syncobj_basic (bad-fd-to-handle)
[532.609013] Starting subtest: bad-fd-to-handle
[532.610971] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[532.747337] [054/132] (514s left) gem_ctx_param (invalid-size-get)
[532.798873] Starting subtest: invalid-size-get
[532.800936] Subtest invalid-size-get: SUCCESS (0.001s)
[532.912072] [055/132] (514s left) gem_exec_fence (syncobj-wait)
[533.338214] Starting subtest: syncobj-wait
[533.405972] Subtest syncobj-wait: SUCCESS (0.068s)
[533.857071] [056/132] (513s left) gem_exec_schedule (preempt-queue-chain)
[533.919404] Subtest preempt-queue-chain: SKIP (0.000s)
[534.298078] [057/132] (513s left) kms_selftest (drm_dp_mst_helper)
[534.344466] Starting subtest: drm_dp_mst_helper
[534.418600] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[534.425141] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.071s)
[534.457714] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[534.508225] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.079s)
[534.530390] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[534.636102] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.126s)
[534.644784] Subtest drm_dp_mst_helper: SUCCESS (0.294s)
[534.851341] [058/132] (513s left) gem_mmap_gtt (isolation)
[534.898731] Subtest isolation: SKIP (0.000s)
[534.991278] [059/132] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[536.493024] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[536.496470] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[536.664004] [060/132] (511s left) kms_psr (pr-dpms)
[538.181690] Subtest pr-dpms: SKIP (0.000s)
[538.269298] [061/132] (509s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[539.764993] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[539.768013] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[539.993101] [062/132] (508s left) gem_exec_fence (basic-busy-all)
[540.092951] Starting subtest: basic-busy-all
[540.169073] Subtest basic-busy-all: SUCCESS (0.078s)
[540.928617] [063/132] (507s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[540.977069] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[540.979055] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[541.097140] [064/132] (507s left) kms_cdclk (mode-transition)
[541.146528] Subtest mode-transition: SKIP (0.000s)
[541.221580] [065/132] (507s left) kms_flip (bo-too-big-interruptible)
[542.722075] Starting subtest: bo-too-big-interruptible
[542.730620] Starting dynamic subtest: A-HDMI-A4
[542.932239] Dynamic subtest A-HDMI-A4: SUCCESS (0.202s)
[542.948811] Starting dynamic subtest: B-HDMI-A4
[543.061574] Dynamic subtest B-HDMI-A4: SUCCESS (0.128s)
[543.075942] Starting dynamic subtest: C-HDMI-A4
[543.193863] Dynamic subtest C-HDMI-A4: SUCCESS (0.130s)
[543.208580] Starting dynamic subtest: D-HDMI-A4
[543.325892] Dynamic subtest D-HDMI-A4: SUCCESS (0.130s)
[543.327584] Subtest bo-too-big-interruptible: SUCCESS (0.604s)
[543.537104] [066/132] (505s left) gem_ctx_isolation (dirty-create)
[543.596265] Starting subtest: dirty-create
[543.597669] Starting dynamic subtest: rcs0
[544.350760] Dynamic subtest rcs0: SUCCESS (0.754s)
[544.363341] Starting dynamic subtest: bcs0
[545.146373] Dynamic subtest bcs0: SUCCESS (0.794s)
[545.159021] Starting dynamic subtest: vcs0
[545.984515] Dynamic subtest vcs0: SUCCESS (0.836s)
[545.997085] Starting dynamic subtest: vcs1
[546.815325] Dynamic subtest vcs1: SUCCESS (0.829s)
[546.828044] Starting dynamic subtest: vecs0
[547.655124] Dynamic subtest vecs0: SUCCESS (0.838s)
[547.656927] Subtest dirty-create: SUCCESS (4.059s)
[547.935440] [067/132] (500s left) kms_pipe_stress (stress-xrgb8888-untiled)
[549.425192] Starting subtest: stress-xrgb8888-untiled
[562.606692] Subtest stress-xrgb8888-untiled: SUCCESS (13.181s)
[562.786578] [068/132] (486s left) gem_close_race (basic-process)
[562.887015] Starting subtest: basic-process
[562.944022] Subtest basic-process: SUCCESS (0.056s)
[563.236388] [069/132] (485s left) kms_feature_discovery (psr1)
[564.724506] Starting subtest: psr1
[564.727704] Subtest psr1: SKIP (0.000s)
[564.852711] [070/132] (484s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[566.367825] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[567.474663] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.103s)
[567.668075] [071/132] (481s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[569.152709] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[569.187641] Starting dynamic subtest: pipe-A-plane-0
[570.320379] Dynamic subtest pipe-A-plane-0: SUCCESS (1.133s)
[570.358271] Starting dynamic subtest: pipe-A-plane-3
[571.137164] Dynamic subtest pipe-A-plane-3: SUCCESS (0.814s)
[571.179983] Starting dynamic subtest: pipe-A-plane-5
[571.837281] Dynamic subtest pipe-A-plane-5: SUCCESS (0.696s)
[571.998763] Starting dynamic subtest: pipe-B-plane-0
[572.921739] Dynamic subtest pipe-B-plane-0: SUCCESS (0.933s)
[572.966042] Starting dynamic subtest: pipe-B-plane-3
[573.772233] Dynamic subtest pipe-B-plane-3: SUCCESS (0.845s)
[573.824326] Starting dynamic subtest: pipe-B-plane-5
[574.470820] Dynamic subtest pipe-B-plane-5: SUCCESS (0.692s)
[574.527746] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (5.373s)
[574.716497] [072/132] (474s left) gem_exec_balancer (sliced)
[574.794032] Starting subtest: sliced
[574.797080] Subtest sliced: SKIP (0.000s)
[575.231054] [073/132] (474s left) perf_pmu (busy-double-start)
[575.282317] Starting subtest: busy-double-start
[575.283704] Starting dynamic subtest: rcs0
[578.881552] Dynamic subtest rcs0: SUCCESS (3.598s)
[578.899110] Starting dynamic subtest: bcs0
[582.464559] Dynamic subtest bcs0: SUCCESS (3.581s)
[582.481476] Starting dynamic subtest: vcs0
[586.053641] Dynamic subtest vcs0: SUCCESS (3.587s)
[586.071773] Starting dynamic subtest: vcs1
[589.622660] Dynamic subtest vcs1: SUCCESS (3.567s)
[589.643002] Starting dynamic subtest: vecs0
[593.211646] Dynamic subtest vecs0: SUCCESS (3.587s)
[593.213325] Subtest busy-double-start: SUCCESS (17.930s)
[593.331487] [074/132] (455s left) kms_flip (flip-vs-expired-vblank)
[594.817125] Starting subtest: flip-vs-expired-vblank
[594.824735] Starting dynamic subtest: A-HDMI-A4
[602.559156] Dynamic subtest A-HDMI-A4: SUCCESS (7.734s)
[602.575676] Starting dynamic subtest: B-HDMI-A4
[610.237106] Dynamic subtest B-HDMI-A4: SUCCESS (7.675s)
[610.253651] Starting dynamic subtest: C-HDMI-A4
[617.917270] Dynamic subtest C-HDMI-A4: SUCCESS (7.676s)
[617.941445] Starting dynamic subtest: D-HDMI-A4
[625.591942] Dynamic subtest D-HDMI-A4: SUCCESS (7.667s)
[625.593444] Subtest flip-vs-expired-vblank: SUCCESS (30.775s)
[625.817772] [075/132] (423s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[627.312768] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[627.315668] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[627.502111] [076/132] (421s left) perf (buffer-fill)
[627.625873] Starting subtest: buffer-fill
[627.627524] Starting dynamic subtest: 0-rcs0
[629.866100] Dynamic subtest 0-rcs0: SUCCESS (2.236s)
[629.867682] Subtest buffer-fill: SUCCESS (2.238s)
[629.950108] [077/132] (419s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[633.668657] Starting subtest: modeset-non-lpsp-stress-no-wait
[636.007656] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (2.344s)
[636.230137] [078/132] (413s left) kms_content_protection (atomic-dpms-hdcp14)
[637.791701] Starting subtest: atomic-dpms-hdcp14
[637.799890] Subtest atomic-dpms-hdcp14: SKIP (0.005s)
[637.992555] [079/132] (411s left) prime_vgem (basic-fence-read)
[638.065240] Starting subtest: basic-fence-read
[638.093000] Subtest basic-fence-read: SKIP (0.024s)
[638.294673] [080/132] (411s left) kms_properties (get_properties-sanity-non-atomic)
[639.793706] Starting subtest: get_properties-sanity-non-atomic
[639.795158] Subtest get_properties-sanity-non-atomic: SUCCESS (0.004s)
[639.913564] [081/132] (410s left) gem_partial_pwrite_pread (write)
[639.970837] Subtest write: SKIP (0.000s)
[640.070462] [082/132] (409s left) kms_properties (plane-properties-atomic)
[641.555088] Starting subtest: plane-properties-atomic
[641.556845] Starting dynamic subtest: pipe-A-HDMI-A-4
[642.029213] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.471s)
[642.042765] Starting dynamic subtest: pipe-B-HDMI-A-4
[642.486375] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.455s)
[642.500224] Starting dynamic subtest: pipe-C-HDMI-A-4
[642.951888] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.463s)
[642.966359] Starting dynamic subtest: pipe-D-HDMI-A-4
[643.416945] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.464s)
[643.418376] Subtest plane-properties-atomic: SUCCESS (1.863s)
[643.617018] [083/132] (406s left) syncobj_timeline (invalid-wait-bad-flags)
[643.667374] Starting subtest: invalid-wait-bad-flags
[643.668933] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[643.801644] [084/132] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[645.294308] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[645.297579] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[645.483563] [085/132] (404s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[646.972197] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[646.974941] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[647.087565] [086/132] (403s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[648.587082] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[648.590179] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[648.769628] [087/132] (401s left) gem_readwrite (write-bad-handle)
[648.817611] Subtest write-bad-handle: SKIP (0.000s)
[648.914298] [088/132] (401s left) sw_sync (timeline_closed_signaled)
[648.977877] Starting subtest: timeline_closed_signaled
[648.980769] Subtest timeline_closed_signaled: SUCCESS (0.001s)
[649.182354] [089/132] (401s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[652.699971] Starting subtest: dpms-mode-unset-non-lpsp
[655.875545] Subtest dpms-mode-unset-non-lpsp: SUCCESS (3.180s)
[656.929407] [090/132] (393s left) kms_addfb_basic (bad-pitch-63)
[656.981490] Starting subtest: bad-pitch-63
[656.982984] Subtest bad-pitch-63: SUCCESS (0.000s)
[658.591062] [091/132] (392s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[660.085183] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[660.088445] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[660.270381] [092/132] (390s left) gem_userptr_blits (map-fixed-invalidate-busy)
[660.332870] Starting subtest: map-fixed-invalidate-busy
[660.336240] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[660.545429] [093/132] (390s left) perf_pmu (busy-idle)
[660.604393] Starting subtest: busy-idle
[660.605804] Starting dynamic subtest: rcs0
[661.303488] Dynamic subtest rcs0: SUCCESS (0.705s)
[661.322448] Starting dynamic subtest: bcs0
[661.965319] Dynamic subtest bcs0: SUCCESS (0.660s)
[661.983462] Starting dynamic subtest: vcs0
[662.627393] Dynamic subtest vcs0: SUCCESS (0.660s)
[662.645723] Starting dynamic subtest: vcs1
[663.290468] Dynamic subtest vcs1: SUCCESS (0.661s)
[663.308634] Starting dynamic subtest: vecs0
[663.953429] Dynamic subtest vecs0: SUCCESS (0.661s)
[663.955081] Subtest busy-idle: SUCCESS (3.357s)
[664.100641] [094/132] (387s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[665.592811] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[665.595626] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[665.749856] [095/132] (385s left) kms_psr (psr-sprite-mmap-gtt)
[667.243867] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[667.319216] [096/132] (384s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[668.844772] Starting subtest: cursorB-vs-flipA-varying-size
[668.847396] Subtest cursorB-vs-flipA-varying-size: SKIP (0.003s)
[668.958342] [097/132] (382s left) gem_create (create-ext-placement-all)
[669.141372] Starting subtest: create-ext-placement-all
[669.144001] Subtest create-ext-placement-all: SUCCESS (0.000s)
[669.303333] [098/132] (382s left) gem_render_copy (linear-to-vebox-yf-tiled)
[669.357777] Starting subtest: linear-to-vebox-yf-tiled
[669.359247] Starting dynamic subtest: smem
[669.440562] Dynamic subtest smem: SUCCESS (0.082s)
[669.454417] Starting dynamic subtest: lmem0
[670.202448] Dynamic subtest lmem0: SUCCESS (0.757s)
[670.204151] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.842s)
[670.460551] [099/132] (381s left) kms_color (ctm-max)
[671.993180] Starting subtest: ctm-max
[671.994641] Starting dynamic subtest: pipe-A-HDMI-A-4
[672.674779] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.683s)
[672.688345] Starting dynamic subtest: pipe-B-HDMI-A-4
[673.199642] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.524s)
[673.217419] Starting dynamic subtest: pipe-C-HDMI-A-4
[673.671874] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.469s)
[673.686005] Starting dynamic subtest: pipe-D-HDMI-A-4
[674.202578] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.527s)
[674.203967] Subtest ctm-max: SUCCESS (2.208s)
[674.382497] [100/132] (377s left) kms_psr (psr2-no-drrs)
[675.880643] Subtest psr2-no-drrs: SKIP (0.000s)
[675.959702] [101/132] (375s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[677.468218] Starting subtest: yf-tiled-8bpp-rotate-270
[677.472023] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[677.628948] [102/132] (374s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[679.118400] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[679.341684] Starting dynamic subtest: pipe-A-HDMI-A-4
[681.672334] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.317s)
[681.872160] Starting dynamic subtest: pipe-B-HDMI-A-4
[683.911593] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.048s)
[684.103295] Starting dynamic subtest: pipe-C-HDMI-A-4
[686.153992] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.059s)
[686.332658] Starting dynamic subtest: pipe-D-HDMI-A-4
[688.377759] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.054s)
[688.379966] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.260s)
[688.724464] [103/132] (363s left) kms_psr2_su (page_flip-xrgb8888)
[688.773242] Subtest page_flip-XRGB8888: SKIP (0.000s)
[688.856865] [104/132] (363s left) syncobj_eventfd (invalid-illegal-handle)
[688.906107] Starting subtest: invalid-illegal-handle
[688.907672] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[689.042123] [105/132] (363s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[690.532795] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[690.535761] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[690.695367] [106/132] (361s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[692.189804] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[692.192545] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[692.445477] [107/132] (359s left) gem_mmap_gtt (basic-small-bo-tiledx)
[692.508226] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[692.589255] [108/132] (359s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[694.084666] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[694.088042] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[694.276501] [109/132] (358s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[695.785171] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[696.893753] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.105s)
[697.091625] [110/132] (355s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[698.580753] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[698.655732] [111/132] (354s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[698.704533] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[698.811950] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[699.003392] [112/132] (353s left) gem_softpin (allocator-basic)
[699.056463] Starting subtest: allocator-basic
[699.334996] Subtest allocator-basic: SUCCESS (0.275s)
[699.533477] [113/132] (353s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[701.024599] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[701.027259] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[701.217670] [114/132] (351s left) gem_flink_basic (bad-open)
[701.264846] Starting subtest: bad-open
[701.266461] Subtest bad-open: SUCCESS (0.000s)
[701.376682] [115/132] (351s left) gem_exec_whisper (basic-fds-priority-all)
[701.436384] Starting subtest: basic-fds-priority-all
[715.455466] Subtest basic-fds-priority-all: SUCCESS (14.014s)
[715.687060] [116/132] (337s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[717.169715] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[717.171220] Starting dynamic subtest: pipe-A
[717.271645] Dynamic subtest pipe-A: SUCCESS (0.101s)
[717.286023] Starting dynamic subtest: pipe-B
[717.411311] Dynamic subtest pipe-B: SUCCESS (0.138s)
[717.425050] Starting dynamic subtest: pipe-C
[717.550994] Dynamic subtest pipe-C: SUCCESS (0.138s)
[717.565086] Starting dynamic subtest: pipe-D
[717.691215] Dynamic subtest pipe-D: SUCCESS (0.139s)
[717.692943] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.522s)
[717.886543] [117/132] (335s left) gem_ctx_param (basic)
[717.936442] Starting subtest: basic
[717.938137] Subtest basic: SUCCESS (0.001s)
[718.056143] [118/132] (335s left) kms_cursor_edge_walk (64x64-top-bottom)
[719.543816] Starting subtest: 64x64-top-bottom
[719.545268] Starting dynamic subtest: pipe-A-HDMI-A-4
[722.844512] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.299s)
[722.858779] Starting dynamic subtest: pipe-D-HDMI-A-4
[726.052128] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.205s)
[726.054087] Subtest 64x64-top-bottom: SUCCESS (6.510s)
[726.388107] [119/132] (327s left) kms_psr (fbc-psr-primary-blt)
[727.944242] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[728.033567] [120/132] (325s left) gem_mmap_gtt (cpuset-big-copy-xy)
[728.083726] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[728.166498] [121/132] (325s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[728.224828] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[728.226568] Starting dynamic subtest: smem
[728.313880] Dynamic subtest smem: SUCCESS (0.090s)
[728.328036] Starting dynamic subtest: lmem0
[729.254871] Dynamic subtest lmem0: SUCCESS (0.936s)
[729.256935] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (1.029s)
[729.539503] [122/132] (324s left) api_intel_allocator (default-alignment)
[729.585955] Starting subtest: default-alignment
[729.591744] Subtest default-alignment: SUCCESS (0.006s)
[729.813307] [123/132] (324s left) kms_lease (lease-get)
[731.299789] Starting subtest: lease-get
[731.301531] Starting dynamic subtest: pipe-A-HDMI-A-4
[731.303097] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[731.318123] Starting dynamic subtest: pipe-B-HDMI-A-4
[731.319788] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[731.333893] Starting dynamic subtest: pipe-C-HDMI-A-4
[731.335869] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[731.349722] Starting dynamic subtest: pipe-D-HDMI-A-4
[731.351546] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[731.355510] Subtest lease-get: SUCCESS (0.016s)
[731.472485] [124/132] (322s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[732.964875] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[732.968465] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[733.171677] [125/132] (320s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[734.658874] Starting subtest: plane-use-after-nonblocking-unbind
[734.663139] Starting dynamic subtest: pipe-A-HDMI-A-4
[734.750052] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.089s)
[734.822537] Starting dynamic subtest: pipe-B-HDMI-A-4
[734.973938] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.166s)
[735.014052] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.354s)
[735.190649] [126/132] (318s left) kms_busy (extended-pageflip-hang-newfb)
[736.685266] Starting subtest: extended-pageflip-hang-newfb
[736.686786] Starting dynamic subtest: pipe-A
[744.491513] Dynamic subtest pipe-A: SUCCESS (7.806s)
[744.509403] Starting dynamic subtest: pipe-D
[752.255762] Dynamic subtest pipe-D: SUCCESS (7.759s)
[752.257487] Subtest extended-pageflip-hang-newfb: SUCCESS (15.574s)
[752.455251] [127/132] (301s left) dumb_buffer (create-valid-dumb)
[752.501760] Starting subtest: create-valid-dumb
[752.505941] Subtest create-valid-dumb: SUCCESS (0.000s)
[752.670566] [128/132] (301s left) gem_lmem_swapping (heavy-multi)
[756.791706] Starting subtest: heavy-multi
[756.793281] Starting dynamic subtest: lmem0
[763.545707] Dynamic subtest lmem0: SUCCESS (6.751s)
[763.547251] Subtest heavy-multi: SUCCESS (6.752s)
[765.050406] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[765.051781] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[765.054784] [129/132] (289s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[769.761190] Starting subtest: psr-1p-primscrn-cur-indfb-move
[769.764243] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[769.989867] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[769.993145] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)] new: kernel.kmod_is_loaded.i915: true
[770.000599] [130/132] (284s left) perf_pmu (all-busy-check-all)
[770.058574] Starting subtest: all-busy-check-all
[770.636650] Subtest all-busy-check-all: SUCCESS (0.578s)
[770.769627] [131/132] (283s left) gem_exec_nop (basic-parallel)
[770.832869] Starting subtest: basic-parallel
[774.562238] Subtest basic-parallel: SUCCESS (3.733s)
[774.890382] [132/132] (279s left) gem_exec_flush (basic-batch-kernel-default-uc)
[774.953963] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[775.062175] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: i915_pm_rpm
results: parsing output: 2/ for test: vgem_basic
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: gem_busy
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: kms_rotation_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: prime_self_import
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: gem_wait
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: i915_hangman
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: i915_selftest
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: kms_dither
results: parsing output: 30/ for test: gem_exec_flush
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: prime_mmap
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: kms_chamelium_edid
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: gem_set_tiling_vs_blt
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_joiner
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: syncobj_basic
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_selftest
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_cdclk
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_ctx_isolation
results: parsing output: 66/ for test: kms_pipe_stress
results: parsing output: 67/ for test: gem_close_race
results: parsing output: 68/ for test: kms_feature_discovery
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_pm_rpm
results: parsing output: 77/ for test: kms_content_protection
results: parsing output: 78/ for test: prime_vgem
results: parsing output: 79/ for test: kms_properties
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: kms_properties
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_readwrite
results: parsing output: 87/ for test: sw_sync
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_create
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_color
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_psr2_su
results: parsing output: 103/ for test: syncobj_eventfd
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_flink_basic
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: gem_ctx_param
results: parsing output: 117/ for test: kms_cursor_edge_walk
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: api_intel_allocator
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_atomic_transition
results: parsing output: 125/ for test: kms_busy
results: parsing output: 126/ for test: dumb_buffer
results: parsing output: 127/ for test: gem_lmem_swapping
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: gem_exec_nop
results: parsing output: 131/ for test: gem_exec_flush
Done.