[73.533430] Initializing watchdogs
[73.533511]   /dev/watchdog0
[73.564010] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[73.578765] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[73.583677] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.587236] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[75.344219] Starting subtest: cursor-offscreen-256x85
[75.361021] Starting dynamic subtest: pipe-A-HDMI-A-4
[77.854842] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.494s)
[77.888099] Starting dynamic subtest: pipe-D-HDMI-A-4
[80.256793] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.376s)
[80.258361] Subtest cursor-offscreen-256x85: SUCCESS (4.911s)
[80.588553] [002/133] (953s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[82.076830] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[82.078328] Starting dynamic subtest: pipe-A-HDMI-A-4
[82.119881] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[82.128176] Starting dynamic subtest: pipe-B-HDMI-A-4
[82.171030] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[82.179220] Starting dynamic subtest: pipe-C-HDMI-A-4
[82.227713] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[82.235807] Starting dynamic subtest: pipe-D-HDMI-A-4
[82.276390] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[82.279674] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.016s)
[82.344778] [003/133] (951s left) sysfs_timeslice_duration (duration)
[82.403892] Starting subtest: duration
[82.405607] Starting dynamic subtest: vecs0
[95.545923] Dynamic subtest vecs0: SUCCESS (13.140s)
[95.555769] Starting dynamic subtest: vcs0
[108.688539] Dynamic subtest vcs0: SUCCESS (13.140s)
[108.697992] Starting dynamic subtest: bcs0
[121.825886] Dynamic subtest bcs0: SUCCESS (13.137s)
[121.835635] Starting dynamic subtest: rcs0
[134.966987] Dynamic subtest rcs0: SUCCESS (13.140s)
[134.977029] Starting dynamic subtest: vcs1
[148.106825] Dynamic subtest vcs1: SUCCESS (13.139s)
[148.108356] Subtest duration: SUCCESS (65.703s)
[148.226141] [004/133] (886s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[149.713937] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[149.715718] Starting dynamic subtest: pipe-A-HDMI-A-4
[149.731385] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[149.740282] Starting dynamic subtest: pipe-B-HDMI-A-4
[149.745882] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[149.753990] Starting dynamic subtest: pipe-C-HDMI-A-4
[149.759709] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[149.767692] Starting dynamic subtest: pipe-D-HDMI-A-4
[149.773378] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[149.776168] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[149.946458] [005/133] (884s left) drm_buddy (drm_buddy)
[149.993587] Starting subtest: drm_buddy
[149.996930] Subtest drm_buddy: SKIP (0.001s)
[150.079417] [006/133] (884s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[151.591527] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[152.187632] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.597s)
[152.407304] [007/133] (882s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[153.894562] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[153.896162] Starting dynamic subtest: pipe-A-HDMI-A-4
[153.913787] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[153.922606] Starting dynamic subtest: pipe-B-HDMI-A-4
[153.942768] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[153.951095] Starting dynamic subtest: pipe-C-HDMI-A-4
[153.969625] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[153.977713] Starting dynamic subtest: pipe-D-HDMI-A-4
[153.992168] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[153.994706] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[154.156700] [008/133] (880s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[155.643911] Starting subtest: bad-pixel-format-yf-tiled-ccs
[155.645811] Starting dynamic subtest: pipe-A-HDMI-A-4
[155.671527] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[155.680124] Starting dynamic subtest: pipe-B-HDMI-A-4
[155.694196] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[155.702471] Starting dynamic subtest: pipe-C-HDMI-A-4
[155.716933] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[155.725271] Starting dynamic subtest: pipe-D-HDMI-A-4
[155.742894] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[155.745972] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.006s)
[155.872574] [009/133] (878s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[155.923195] Starting subtest: multi-wait-available-unsubmitted-submitted
[155.924969] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[156.076621] [010/133] (878s left) perf_pmu (event-wait)
[156.151193] Starting subtest: event-wait
[156.152927] Starting dynamic subtest: rcs0
[156.156409] Dynamic subtest rcs0: SKIP (0.000s)
[156.160152] Subtest event-wait: SKIP (0.000s)
[156.256713] [011/133] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[157.762137] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[157.765277] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[157.942721] [012/133] (877s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[159.461227] Starting subtest: psr-rgb565-draw-mmap-gtt
[159.464347] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[159.650104] [013/133] (875s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[161.141860] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[161.216432] [014/133] (873s left) kms_psr (fbc-psr2-dpms)
[162.706154] Subtest fbc-psr2-dpms: SKIP (0.000s)
[162.783075] [015/133] (872s left) gem_exec_balancer (parallel-ordering)
[163.208361] Starting subtest: parallel-ordering
[165.365110] Subtest parallel-ordering: SUCCESS (2.158s)
[165.562524] [016/133] (869s left) kms_joiner (basic-big-joiner)
[167.052591] Starting subtest: basic-big-joiner
[167.055364] Subtest basic-big-joiner: SKIP (0.000s)
[167.169907] [017/133] (868s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[168.669702] Starting subtest: flip-vs-cursor-crc-atomic
[169.218677] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.547s)
[169.380584] [018/133] (866s left) gem_wait (wait)
[169.444097] Starting subtest: wait
[169.445778] Starting dynamic subtest: all-engines
[170.534728] Dynamic subtest all-engines: SUCCESS (1.090s)
[170.545920] Starting dynamic subtest: rcs0
[171.589684] Dynamic subtest rcs0: SUCCESS (1.054s)
[171.600895] Starting dynamic subtest: bcs0
[172.644911] Dynamic subtest bcs0: SUCCESS (1.055s)
[172.655969] Starting dynamic subtest: vcs0
[173.699681] Dynamic subtest vcs0: SUCCESS (1.055s)
[173.714370] Starting dynamic subtest: vcs1
[174.753998] Dynamic subtest vcs1: SUCCESS (1.054s)
[174.765228] Starting dynamic subtest: vecs0
[175.806687] Dynamic subtest vecs0: SUCCESS (1.053s)
[175.808535] Subtest wait: SUCCESS (6.363s)
[176.071186] [019/133] (859s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[177.564379] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[177.567520] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[177.760012] [020/133] (857s left) kms_flip (2x-flip-vs-expired-vblank)
[179.250586] Starting subtest: 2x-flip-vs-expired-vblank
[179.266782] Subtest 2x-flip-vs-expired-vblank: SKIP (0.017s)
[179.410334] [021/133] (856s left) kms_lease (page-flip-implicit-plane)
[180.906426] Starting subtest: page-flip-implicit-plane
[180.907936] Starting dynamic subtest: pipe-A-HDMI-A-4
[181.327700] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.421s)
[181.336842] Starting dynamic subtest: pipe-B-HDMI-A-4
[181.573610] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.246s)
[181.586715] Starting dynamic subtest: pipe-C-HDMI-A-4
[181.855121] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.279s)
[181.864168] Starting dynamic subtest: pipe-D-HDMI-A-4
[182.124342] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.268s)
[182.125701] Subtest page-flip-implicit-plane: SUCCESS (1.219s)
[182.304842] [022/133] (853s left) gem_exec_params (rsvd2-dirt)
[182.357960] Starting subtest: rsvd2-dirt
[182.361208] Subtest rsvd2-dirt: SKIP (0.000s)
[182.549262] [023/133] (853s left) api_intel_bb (blit-reloc-purge-cache)
[182.595818] Starting subtest: blit-reloc-purge-cache
[182.599145] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[182.778564] [024/133] (853s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[184.272501] Starting subtest: fbc-shrfb-scaledprimary
[187.975828] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.705s)
[188.158150] [025/133] (847s left) i915_pm_rpm (gem-idle)
[191.968858] Starting subtest: gem-idle
[198.045191] Subtest gem-idle: SUCCESS (6.074s)
[198.903205] [026/133] (837s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[200.417721] Starting subtest: x-tiled-8bpp-rotate-0
[202.086875] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.663s)
[202.251349] [027/133] (833s left) gem_exec_schedule (preempt-contexts)
[202.313658] Starting subtest: preempt-contexts
[202.314994] Starting dynamic subtest: rcs0
[202.402904] Dynamic subtest rcs0: SUCCESS (0.089s)
[202.411929] Starting dynamic subtest: bcs0
[202.472047] Dynamic subtest bcs0: SUCCESS (0.069s)
[202.481119] Starting dynamic subtest: vcs0
[202.542787] Dynamic subtest vcs0: SUCCESS (0.070s)
[202.551848] Starting dynamic subtest: vcs1
[202.613690] Dynamic subtest vcs1: SUCCESS (0.070s)
[202.622723] Starting dynamic subtest: vecs0
[202.683212] Dynamic subtest vecs0: SUCCESS (0.069s)
[202.687517] Subtest preempt-contexts: SUCCESS (0.370s)
[203.110895] [028/133] (833s left) gem_exec_flush (basic-uc-rw-default)
[203.165108] Subtest basic-uc-rw-default: SKIP (0.000s)
[203.254078] [029/133] (833s left) kms_color_pipeline (plane-lut1d)
[204.743974] Starting subtest: plane-lut1d
[204.948334] Starting dynamic subtest: pipe-A-plane-0
[205.197650] Dynamic subtest pipe-A-plane-0: SUCCESS (0.249s)
[205.233124] Starting dynamic subtest: pipe-A-plane-1
[205.397890] Dynamic subtest pipe-A-plane-1: SUCCESS (0.198s)
[205.430482] Starting dynamic subtest: pipe-A-plane-2
[205.597772] Dynamic subtest pipe-A-plane-2: SUCCESS (0.198s)
[205.875960] Starting dynamic subtest: pipe-B-plane-0
[206.036932] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[206.067374] Starting dynamic subtest: pipe-B-plane-1
[206.238484] Dynamic subtest pipe-B-plane-1: SUCCESS (0.198s)
[206.267812] Starting dynamic subtest: pipe-B-plane-2
[206.438211] Dynamic subtest pipe-B-plane-2: SUCCESS (0.198s)
[206.707821] Starting dynamic subtest: pipe-C-plane-0
[206.880268] Dynamic subtest pipe-C-plane-0: SUCCESS (0.183s)
[206.911341] Starting dynamic subtest: pipe-C-plane-1
[207.096245] Dynamic subtest pipe-C-plane-1: SUCCESS (0.214s)
[207.120746] Starting dynamic subtest: pipe-C-plane-2
[207.312906] Dynamic subtest pipe-C-plane-2: SUCCESS (0.215s)
[207.616391] Starting dynamic subtest: pipe-D-plane-0
[207.788103] Dynamic subtest pipe-D-plane-0: SUCCESS (0.183s)
[207.814302] Starting dynamic subtest: pipe-D-plane-1
[208.004726] Dynamic subtest pipe-D-plane-1: SUCCESS (0.214s)
[208.029846] Starting dynamic subtest: pipe-D-plane-2
[208.204774] Dynamic subtest pipe-D-plane-2: SUCCESS (0.198s)
[208.243926] Subtest plane-lut1d: SUCCESS (3.499s)
[208.419378] [030/133] (827s left) gem_exec_schedule (deep)
[208.603359] Starting subtest: deep
[208.605020] Starting dynamic subtest: rcs0
[224.319625] Dynamic subtest rcs0: SUCCESS (15.714s)
[224.328948] Starting dynamic subtest: bcs0
[240.470583] Dynamic subtest bcs0: SUCCESS (16.150s)
[240.480170] Starting dynamic subtest: vcs0
[256.490746] Dynamic subtest vcs0: SUCCESS (16.019s)
[256.500336] Starting dynamic subtest: vcs1
[272.718652] Dynamic subtest vcs1: SUCCESS (16.227s)
[272.729099] Starting dynamic subtest: vecs0
[288.827424] Dynamic subtest vecs0: SUCCESS (16.109s)
[288.828763] Subtest deep: SUCCESS (80.223s)
[289.671776] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[289.674326] [031/133] (746s left) kms_cursor_crc (cursor-suspend)
[291.222132] Starting subtest: cursor-suspend
[291.223849] Starting dynamic subtest: pipe-A-HDMI-A-4
[335.237511] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (20.736s)
[335.249124] Starting dynamic subtest: pipe-D-HDMI-A-4
[378.211268] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (20.195s)
[378.212679] Subtest cursor-suspend: SUCCESS (40.935s)
[383.829059] [032/133] (657s left) perf (gen8-unprivileged-single-ctx-counters)
[383.968148] Starting subtest: gen8-unprivileged-single-ctx-counters
[383.970888] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[384.048089] [033/133] (657s left) api_intel_bb (intel-bb-blit-y)
[384.094845] Starting subtest: intel-bb-blit-y
[385.721608] Subtest intel-bb-blit-y: SUCCESS (1.626s)
[385.905998] [034/133] (655s left) prime_mmap (test_refcounting)
[385.954859] Starting subtest: test_refcounting
[385.956337] Starting dynamic subtest: test_refcounting-smem
[386.017431] Dynamic subtest test_refcounting-smem: SUCCESS (0.065s)
[386.028912] Starting dynamic subtest: test_refcounting-lmem0
[386.085082] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.067s)
[386.086589] Subtest test_refcounting: SUCCESS (0.133s)
[386.222937] [035/133] (655s left) kms_atomic_transition (modeset-transition)
[387.711189] Starting subtest: modeset-transition
[387.712686] Starting dynamic subtest: 1x-outputs
[389.682581] Dynamic subtest 1x-outputs: SUCCESS (1.971s)
[389.685145] Subtest modeset-transition: SUCCESS (1.973s)
[389.864101] [036/133] (651s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[391.351874] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[391.353381] Starting dynamic subtest: pipe-A
[392.185191] Dynamic subtest pipe-A: SUCCESS (0.833s)
[392.202766] Starting dynamic subtest: pipe-B
[392.958728] Dynamic subtest pipe-B: SUCCESS (0.773s)
[392.972091] Starting dynamic subtest: pipe-C
[393.733506] Dynamic subtest pipe-C: SUCCESS (0.774s)
[393.748699] Starting dynamic subtest: pipe-D
[394.490723] Dynamic subtest pipe-D: SUCCESS (0.756s)
[394.492368] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.139s)
[394.713296] [037/133] (647s left) kms_frontbuffer_tracking (fbc-suspend)
[396.210704] Starting subtest: fbc-suspend
[441.796181] Subtest fbc-suspend: SUCCESS (23.333s)
[446.091708] [038/133] (599s left) gem_pxp (display-protected-crc)
[448.662932] Starting subtest: display-protected-crc
[448.666426] Subtest display-protected-crc: SKIP (0.000s)
[448.792527] [039/133] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[450.287900] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[450.290891] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[450.447549] [040/133] (595s left) gem_userptr_blits (dmabuf-unsync)
[450.508031] Subtest dmabuf-unsync: SKIP (0.000s)
[450.718392] [041/133] (595s left) gem_eio (context-create)
[450.912551] Starting subtest: context-create
[451.200583] Subtest context-create: SUCCESS (0.288s)
[452.790714] [042/133] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[454.291637] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[454.294518] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[454.482785] [043/133] (591s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[455.977149] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[455.979978] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[456.163925] [044/133] (590s left) kms_selftest (drm_dp_mst_helper)
[456.212982] Starting subtest: drm_dp_mst_helper
[456.287667] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[456.332716] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.073s)
[456.367482] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[456.420148] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.086s)
[456.447317] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[456.555575] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.127s)
[456.558176] Subtest drm_dp_mst_helper: SUCCESS (0.339s)
[456.838061] [045/133] (589s left) gem_spin_batch (resubmit-new)
[456.934228] Starting subtest: resubmit-new
[456.936167] Starting dynamic subtest: rcs0
[456.961320] Dynamic subtest rcs0: SUCCESS (0.026s)
[456.974433] Starting dynamic subtest: bcs0
[456.976194] Dynamic subtest bcs0: SUCCESS (0.005s)
[456.989465] Starting dynamic subtest: vcs0
[456.991410] Dynamic subtest vcs0: SUCCESS (0.005s)
[457.003984] Starting dynamic subtest: vcs1
[457.005987] Dynamic subtest vcs1: SUCCESS (0.005s)
[457.018508] Starting dynamic subtest: vecs0
[457.020541] Dynamic subtest vecs0: SUCCESS (0.005s)
[457.022490] Subtest resubmit-new: SUCCESS (0.050s)
[457.326414] [046/133] (589s left) testdisplay
[463.645621] [047/133] (583s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[465.139993] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[465.219611] [048/133] (581s left) i915_selftest (live)
[466.217723] Starting subtest: live
[466.219596] Starting dynamic subtest: sanitycheck
[467.630479] Dynamic subtest sanitycheck: SUCCESS (1.412s)
[467.642094] Starting dynamic subtest: uncore
[469.041277] Dynamic subtest uncore: SUCCESS (1.410s)
[469.051041] Starting dynamic subtest: workarounds
[472.338757] Dynamic subtest workarounds: SUCCESS (3.296s)
[472.348779] Starting dynamic subtest: gt_engines
[474.311414] Dynamic subtest gt_engines: SUCCESS (1.972s)
[474.321124] Starting dynamic subtest: gt_timelines
[540.285462] Dynamic subtest gt_timelines: SUCCESS (65.973s)
[540.295580] Starting dynamic subtest: gt_contexts
[541.719771] Dynamic subtest gt_contexts: SUCCESS (1.433s)
[541.730193] Starting dynamic subtest: gt_lrc
[547.763699] Dynamic subtest gt_lrc: SUCCESS (6.040s)
[547.773657] Starting dynamic subtest: gt_mocs
[550.047422] Dynamic subtest gt_mocs: SUCCESS (2.283s)
[550.057269] Starting dynamic subtest: gt_pm
[554.053416] Dynamic subtest gt_pm: SUCCESS (4.005s)
[554.063545] Starting dynamic subtest: gt_heartbeat
[555.494331] Dynamic subtest gt_heartbeat: SUCCESS (1.440s)
[555.504119] Starting dynamic subtest: gt_tlb
[569.314644] Dynamic subtest gt_tlb: SUCCESS (13.819s)
[569.324696] Starting dynamic subtest: requests
[580.194736] Dynamic subtest requests: SUCCESS (10.878s)
[580.204596] Starting dynamic subtest: migrate
[584.757021] Dynamic subtest migrate: SUCCESS (4.561s)
[584.767949] Starting dynamic subtest: active
[586.156170] Dynamic subtest active: SUCCESS (1.398s)
[586.166017] Starting dynamic subtest: objects
[588.462426] Dynamic subtest objects: SUCCESS (2.305s)
[588.472600] Starting dynamic subtest: mman
[591.985455] Dynamic subtest mman: SUCCESS (3.521s)
[591.995374] Starting dynamic subtest: dmabuf
[593.456245] Dynamic subtest dmabuf: SUCCESS (1.469s)
[593.466451] Starting dynamic subtest: vma
[594.828452] Dynamic subtest vma: SUCCESS (1.370s)
[594.838521] Starting dynamic subtest: coherency
[604.824415] Dynamic subtest coherency: SUCCESS (9.994s)
[604.834481] Starting dynamic subtest: gtt
[613.805854] Dynamic subtest gtt: SUCCESS (8.980s)
[613.816242] Starting dynamic subtest: gem
[615.350268] Dynamic subtest gem: SUCCESS (1.543s)
[615.361315] Starting dynamic subtest: evict
[626.728910] Dynamic subtest evict: SUCCESS (11.376s)
[626.739070] Starting dynamic subtest: hugepages
[643.819166] Dynamic subtest hugepages: SUCCESS (17.089s)
[643.829223] Starting dynamic subtest: gem_contexts
[671.894273] Dynamic subtest gem_contexts: SUCCESS (28.074s)
[671.903904] Starting dynamic subtest: client
[673.356517] Dynamic subtest client: SUCCESS (1.460s)
[673.367625] Starting dynamic subtest: gem_migrate
[675.932573] Dynamic subtest gem_migrate: SUCCESS (2.575s)
[675.942516] Starting dynamic subtest: reset
[677.366238] Dynamic subtest reset: SUCCESS (1.432s)
[677.376074] Starting dynamic subtest: memory_region
[680.385105] Dynamic subtest memory_region: SUCCESS (3.020s)
[680.395809] Starting dynamic subtest: hangcheck
[708.804296] Dynamic subtest hangcheck: SUCCESS (28.415s)
[708.814072] Starting dynamic subtest: execlists
[710.179412] Dynamic subtest execlists: SUCCESS (1.373s)
[710.189506] Starting dynamic subtest: ring_submission
[711.555878] Dynamic subtest ring_submission: SUCCESS (1.378s)
[711.566065] Starting dynamic subtest: perf
[713.075551] Dynamic subtest perf: SUCCESS (1.515s)
[713.085734] Starting dynamic subtest: slpc
[718.954443] Dynamic subtest slpc: SUCCESS (5.877s)
[718.964887] Starting dynamic subtest: guc
[722.404514] Dynamic subtest guc: SUCCESS (3.449s)
[722.414451] Starting dynamic subtest: guc_multi_lrc
[723.809453] Dynamic subtest guc_multi_lrc: SUCCESS (1.403s)
[723.819502] Starting dynamic subtest: guc_hang
[726.000353] Dynamic subtest guc_hang: SUCCESS (2.189s)
[726.011089] Starting dynamic subtest: late_gt_pm
[727.399265] Dynamic subtest late_gt_pm: SUCCESS (1.398s)
[727.400765] Subtest live: SUCCESS (261.177s)
[727.449993] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[727.451124] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[727.454188] [049/133] (319s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[730.753117] Subtest writes-after-reads-uncached: SKIP (0.000s)
[730.843757] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[730.847234] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true
[730.851342] [050/133] (316s left) kms_getfb (getfb-handle-not-fb)
[732.342442] Starting subtest: getfb-handle-not-fb
[732.343943] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[732.538521] [051/133] (314s left) kms_psr (fbc-psr-sprite-plane-onoff)
[734.027904] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[734.112763] [052/133] (313s left) i915_hangman (gt-error-state-capture)
[734.175821] Starting subtest: gt-error-state-capture
[734.177433] Starting dynamic subtest: rcs0
[744.366737] Dynamic subtest rcs0: SUCCESS (10.192s)
[744.386400] Starting dynamic subtest: bcs0
[754.295521] Dynamic subtest bcs0: SUCCESS (9.927s)
[754.308698] Starting dynamic subtest: vcs0
[764.297903] Dynamic subtest vcs0: SUCCESS (10.001s)
[764.314377] Starting dynamic subtest: vcs1
[774.346875] Dynamic subtest vcs1: SUCCESS (10.047s)
[774.359467] Starting dynamic subtest: vecs0
[783.299515] Dynamic subtest vecs0: SUCCESS (8.951s)
[783.300905] Subtest gt-error-state-capture: SUCCESS (49.126s)
[783.488953] [053/133] (263s left) perf (invalid-open-flags)
[783.616735] Starting subtest: invalid-open-flags
[783.618175] Subtest invalid-open-flags: SUCCESS (0.000s)
[783.701853] [054/133] (263s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[785.205302] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[785.208635] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[785.381634] [055/133] (262s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[786.871782] Starting subtest: async-flip-with-page-flip-events-linear
[787.117898] Starting dynamic subtest: pipe-A-HDMI-A-4
[789.435252] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.313s)
[789.625329] Starting dynamic subtest: pipe-B-HDMI-A-4
[791.671832] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.053s)
[791.857097] Starting dynamic subtest: pipe-C-HDMI-A-4
[793.916130] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.066s)
[794.093037] Starting dynamic subtest: pipe-D-HDMI-A-4
[796.143920] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.058s)
[796.145696] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.273s)
[796.480568] [056/133] (251s left) sw_sync (alloc_fence)
[796.527525] Starting subtest: alloc_fence
[796.529026] Subtest alloc_fence: SUCCESS (0.000s)
[796.637463] [057/133] (251s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[798.123954] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[798.125457] Starting dynamic subtest: pipe-A-valid-mode
[799.360309] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.236s)
[799.361889] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.239s)
[799.553980] [058/133] (248s left) gem_ctx_persistence (heartbeat-close)
[799.609537] Starting subtest: heartbeat-close
[799.613086] Subtest heartbeat-close: SKIP (0.000s)
[799.720054] [059/133] (248s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[801.228392] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[801.231697] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[801.418141] [060/133] (246s left) kms_flip (2x-flip-vs-modeset)
[802.907503] Starting subtest: 2x-flip-vs-modeset
[802.924968] Subtest 2x-flip-vs-modeset: SKIP (0.017s)
[803.074706] [061/133] (245s left) sw_sync (alloc_timeline)
[803.123566] Starting subtest: alloc_timeline
[803.125243] Subtest alloc_timeline: SUCCESS (0.000s)
[803.228670] [062/133] (244s left) gem_exec_fence (syncobj-timeline-chain-engines)
[803.750964] Starting subtest: syncobj-timeline-chain-engines
[803.898648] Subtest syncobj-timeline-chain-engines: SUCCESS (0.148s)
[804.195408] [063/133] (244s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[805.682420] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[805.717987] Starting dynamic subtest: pipe-A-plane-0
[806.251612] Dynamic subtest pipe-A-plane-0: SUCCESS (0.533s)
[806.290138] Starting dynamic subtest: pipe-A-plane-3
[806.584085] Dynamic subtest pipe-A-plane-3: SUCCESS (0.329s)
[806.623367] Starting dynamic subtest: pipe-A-plane-5
[806.917237] Dynamic subtest pipe-A-plane-5: SUCCESS (0.330s)
[807.070423] Starting dynamic subtest: pipe-B-plane-0
[807.442231] Dynamic subtest pipe-B-plane-0: SUCCESS (0.383s)
[807.458486] Starting dynamic subtest: pipe-B-plane-3
[807.792321] Dynamic subtest pipe-B-plane-3: SUCCESS (0.346s)
[807.828544] Starting dynamic subtest: pipe-B-plane-5
[808.126176] Dynamic subtest pipe-B-plane-5: SUCCESS (0.330s)
[808.199786] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.519s)
[808.366594] [064/133] (239s left) perf_pmu (all-busy-check-all)
[808.418658] Starting subtest: all-busy-check-all
[808.987756] Subtest all-busy-check-all: SUCCESS (0.569s)
[809.157393] [065/133] (239s left) kms_chamelium_frames (hdmi-crc-single)
[810.689782] Subtest hdmi-crc-single: SKIP (0.000s)
[810.805351] [066/133] (237s left) kms_draw_crc (draw-method-mmap-wc)
[812.294385] Starting subtest: draw-method-mmap-wc
[812.297502] Subtest draw-method-mmap-wc: SKIP (0.000s)
[812.458412] [067/133] (236s left) kms_content_protection (atomic)
[814.009045] Starting subtest: atomic
[814.021361] Subtest atomic: SKIP (0.005s)
[814.185520] [068/133] (234s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[815.676494] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[815.677996] Starting dynamic subtest: pipe-A-HDMI-A-4
[815.693105] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[815.706630] Starting dynamic subtest: pipe-B-HDMI-A-4
[815.722126] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[815.735128] Starting dynamic subtest: pipe-C-HDMI-A-4
[815.754372] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[815.767478] Starting dynamic subtest: pipe-D-HDMI-A-4
[815.784074] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[815.787440] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.011s)
[815.941480] [069/133] (232s left) kms_psr (pr-primary-render)
[817.430171] Subtest pr-primary-render: SKIP (0.000s)
[817.515516] [070/133] (231s left) gem_exec_flush (basic-uc-ro-default)
[817.570439] Subtest basic-uc-ro-default: SKIP (0.000s)
[817.685449] [071/133] (231s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[819.170738] Starting subtest: fb-8bpc-vs-panel-8bpc
[819.175322] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.001s)
[819.292330] [072/133] (229s left) gem_madvise (dontneed-after-mmap)
[819.344636] Starting subtest: dontneed-after-mmap
[819.352993] Subtest dontneed-after-mmap: SUCCESS (0.005s)
[819.515474] [073/133] (229s left) kms_plane_alpha_blend (constant-alpha-mid)
[821.003812] Starting subtest: constant-alpha-mid
[821.268661] Starting dynamic subtest: pipe-A-HDMI-A-4
[821.978814] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.702s)
[822.004051] Starting dynamic subtest: pipe-D-HDMI-A-4
[822.659832] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.685s)
[822.661220] Subtest constant-alpha-mid: SUCCESS (1.658s)
[822.847018] [074/133] (226s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[822.895448] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[822.979705] [075/133] (226s left) kms_flip (2x-flip-vs-wf_vblank)
[824.466903] Starting subtest: 2x-flip-vs-wf_vblank
[824.485240] Subtest 2x-flip-vs-wf_vblank: SKIP (0.018s)
[824.646776] [076/133] (224s left) kms_cursor_crc (cursor-sliding-128x42)
[826.339315] Starting subtest: cursor-sliding-128x42
[826.347765] Starting dynamic subtest: pipe-A-HDMI-A-4
[830.784435] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.438s)
[830.822422] Starting dynamic subtest: pipe-D-HDMI-A-4
[835.116452] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.306s)
[835.118030] Subtest cursor-sliding-128x42: SUCCESS (8.777s)
[835.490804] [077/133] (213s left) kms_psr (psr2-suspend)
[836.980253] Subtest psr2-suspend: SKIP (0.000s)
[837.055481] [078/133] (212s left) gem_mmap_offset (open-flood)
[837.104216] Starting subtest: open-flood
[858.590079] Subtest open-flood: SUCCESS (21.487s)
[858.731849] [079/133] (190s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[860.227254] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[860.230547] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[860.401191] [080/133] (189s left) gem_exec_nop (basic-sequential)
[860.476961] Starting subtest: basic-sequential
[864.194513] Subtest basic-sequential: SUCCESS (3.730s)
[864.493525] [081/133] (185s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[865.981691] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[865.984634] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[866.096089] [082/133] (183s left) gem_mmap_gtt (basic-small-bo-tiledy)
[866.151639] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[866.236453] [083/133] (183s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[867.743592] Starting subtest: y-tiled-64bpp-rotate-90
[867.814841] Subtest y-tiled-64bpp-rotate-90: SKIP (0.069s)
[868.002843] [084/133] (182s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[869.497209] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[869.499925] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[869.655641] [085/133] (180s left) gem_exec_alignment (single)
[869.711804] Starting subtest: single
[869.718973] Subtest single: SUCCESS (0.007s)
[869.859782] [086/133] (180s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[871.352946] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[871.355821] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[871.540288] [087/133] (178s left) syncobj_timeline (etime-single-wait-submitted)
[871.588899] Starting subtest: etime-single-wait-submitted
[871.695177] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[871.853831] [088/133] (178s left) i915_drm_fdinfo (virtual-busy-all)
[871.905320] Starting subtest: virtual-busy-all
[871.908637] Subtest virtual-busy-all: SKIP (0.000s)
[872.049076] [089/133] (178s left) gem_ctx_exec (basic)
[872.098198] Starting subtest: basic
[872.103784] Subtest basic: SUCCESS (0.006s)
[872.315693] [090/133] (178s left) gem_busy (parallel)
[872.512777] Starting subtest: parallel
[872.514889] Starting dynamic subtest: rcs0
[872.608555] Dynamic subtest rcs0: SUCCESS (0.097s)
[872.624572] Starting dynamic subtest: bcs0
[872.666015] Dynamic subtest bcs0: SUCCESS (0.056s)
[872.683524] Starting dynamic subtest: vcs0
[872.723629] Dynamic subtest vcs0: SUCCESS (0.056s)
[872.754434] Starting dynamic subtest: vcs1
[872.794940] Dynamic subtest vcs1: SUCCESS (0.070s)
[872.824283] Starting dynamic subtest: vecs0
[872.865807] Dynamic subtest vecs0: SUCCESS (0.069s)
[872.867316] Subtest parallel: SUCCESS (0.356s)
[873.161031] [091/133] (177s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[873.209776] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[873.211248] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[873.330557] [092/133] (177s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[874.817181] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[874.819003] Starting dynamic subtest: pipe-A-valid-mode
[876.061371] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.242s)
[876.062781] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.244s)
[876.239626] [093/133] (174s left) kms_vblank (ts-continuation-dpms-rpm)
[877.727453] Starting subtest: ts-continuation-dpms-rpm
[877.731433] Starting dynamic subtest: pipe-A-HDMI-A-4
[880.168505] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.439s)
[880.186516] Starting dynamic subtest: pipe-D-HDMI-A-4
[882.166785] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.993s)
[882.168375] Subtest ts-continuation-dpms-rpm: SUCCESS (4.440s)
[882.349591] [094/133] (168s left) sw_sync (timeline_closed_signaled)
[882.395966] Starting subtest: timeline_closed_signaled
[882.397646] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[882.485075] [095/133] (168s left) gem_lmem_swapping (verify)
[886.669513] Starting subtest: verify
[886.671461] Starting dynamic subtest: lmem0
[927.130504] Dynamic subtest lmem0: SUCCESS (40.459s)
[927.131842] Subtest verify: SUCCESS (40.460s)
[928.480044] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[928.481186] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[928.483992] [096/133] (122s left) syncobj_wait (invalid-signal-zero-handles)
[931.807364] Starting subtest: invalid-signal-zero-handles
[931.808739] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[931.901920] [FACT syncobj_wait (invalid-signal-zero-handles)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[931.905504] [FACT syncobj_wait (invalid-signal-zero-handles)] new: kernel.kmod_is_loaded.i915: true
[931.910084] [097/133] (119s left) kms_pm_rpm (i2c)
[936.349576] Starting subtest: i2c
[940.050735] Subtest i2c: SUCCESS (3.699s)
[940.912196] [098/133] (110s left) vgem_basic (setversion)
[940.982900] Starting subtest: setversion
[940.986025] Subtest setversion: SUCCESS (0.000s)
[941.087944] [099/133] (110s left) gem_exec_reloc (basic-write-gtt)
[941.146931] Subtest basic-write-gtt: SKIP (0.000s)
[941.243217] [100/133] (110s left) kms_scaling_modes (scaling-mode-center)
[942.731009] Starting subtest: scaling-mode-center
[942.739839] Subtest scaling-mode-center: SKIP (0.002s)
[942.863739] [101/133] (108s left) perf_pmu (frequency)
[942.926237] Starting subtest: frequency
[942.930240] Starting dynamic subtest: gt0
[945.233055] Dynamic subtest gt0: FAIL (2.196s)
[945.248070] Starting dynamic subtest: idle-gt0
[945.637126] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[945.638570] Subtest frequency: FAIL (2.711s)
[945.755642] [102/133] (105s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[947.261536] Starting subtest: 4-tiled-32bpp-rotate-180
[947.264592] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[947.467346] [103/133] (104s left) kms_hdr (bpc-switch-dpms)
[948.955711] Starting subtest: bpc-switch-dpms
[948.959696] Subtest bpc-switch-dpms: SKIP (0.001s)
[949.072057] [104/133] (102s left) syncobj_timeline (wait-any-interrupted)
[949.128189] Starting subtest: wait-any-interrupted
[949.235021] Subtest wait-any-interrupted: SUCCESS (0.102s)
[949.422037] [105/133] (102s left) gem_exec_parallel (contexts)
[949.479183] Starting subtest: contexts
[949.480830] Starting dynamic subtest: rcs0
[953.995524] Dynamic subtest rcs0: SUCCESS (4.512s)
[954.008110] Starting dynamic subtest: bcs0
[959.059022] Dynamic subtest bcs0: SUCCESS (5.062s)
[959.071896] Starting dynamic subtest: vcs0
[963.965297] Dynamic subtest vcs0: SUCCESS (4.905s)
[963.978206] Starting dynamic subtest: vcs1
[968.041246] Dynamic subtest vcs1: SUCCESS (4.074s)
[968.055544] Starting dynamic subtest: vecs0
[973.063655] Dynamic subtest vecs0: SUCCESS (5.020s)
[973.065303] Subtest contexts: SUCCESS (23.582s)
[973.391471] [106/133] ( 78s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[975.966638] Starting subtest: verify-pxp-key-change-after-suspend-resume
[975.970108] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[976.093685] [107/133] ( 75s left) gem_create (create-ext-placement-each)
[976.258166] Starting subtest: create-ext-placement-each
[976.259980] Subtest create-ext-placement-each: SUCCESS (0.000s)
[976.442735] [108/133] ( 75s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[977.940843] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[977.942638] Starting dynamic subtest: pipe-A-HDMI-A-4
[977.960477] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[977.974158] Starting dynamic subtest: pipe-B-HDMI-A-4
[977.992378] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[978.005606] Starting dynamic subtest: pipe-C-HDMI-A-4
[978.022072] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[978.034988] Starting dynamic subtest: pipe-D-HDMI-A-4
[978.049398] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[978.052276] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.011s)
[978.211811] [109/133] ( 74s left) gem_close_race (basic-process)
[978.288205] Starting subtest: basic-process
[978.328935] Subtest basic-process: SUCCESS (0.041s)
[978.589418] [110/133] ( 73s left) gem_exec_schedule (u-independent)
[978.649624] Starting subtest: u-independent
[978.651282] Starting dynamic subtest: rcs0
[978.891394] Dynamic subtest rcs0: SUCCESS (0.241s)
[978.904843] Starting dynamic subtest: bcs0
[979.091933] Dynamic subtest bcs0: SUCCESS (0.199s)
[979.121847] Starting dynamic subtest: vcs0
[979.307062] Dynamic subtest vcs0: SUCCESS (0.213s)
[979.338566] Starting dynamic subtest: vcs1
[979.519614] Dynamic subtest vcs1: SUCCESS (0.211s)
[979.542608] Starting dynamic subtest: vecs0
[979.733623] Dynamic subtest vecs0: SUCCESS (0.212s)
[979.735253] Subtest u-independent: SUCCESS (1.085s)
[980.196761] [111/133] ( 72s left) gen9_exec_parse (batch-without-end)
[980.249363] Subtest batch-without-end: SKIP (0.000s)
[980.325007] [112/133] ( 72s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[984.367678] Starting subtest: dpms-mode-unset-lpsp
[985.342724] Subtest dpms-mode-unset-lpsp: SKIP (0.976s)
[986.405320] [113/133] ( 66s left) kms_chamelium_hpd (vga-hpd)
[987.957367] Subtest vga-hpd: SKIP (0.000s)
[988.136987] [114/133] ( 64s left) gem_lmem_swapping (heavy-multi)
[992.340673] Starting subtest: heavy-multi
[992.343291] Starting dynamic subtest: lmem0
[998.538156] Dynamic subtest lmem0: SUCCESS (6.197s)
[998.539884] Subtest heavy-multi: SUCCESS (6.199s)
[999.908587] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[999.909717] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[999.912966] [115/133] ( 52s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[1004.689168] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[1004.865777] [FACT kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[1004.871574] [FACT kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)] new: kernel.kmod_is_loaded.i915: true
[1004.879880] [116/133] ( 48s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[1006.376905] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[1006.380469] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[1006.571317] [117/133] ( 46s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[1008.065676] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[1011.064439] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.000s)
[1011.270824] [118/133] ( 41s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[1012.767826] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[1012.770827] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[1012.986714] [119/133] ( 40s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[1014.479962] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[1014.482676] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[1014.662864] [120/133] ( 38s left) gem_exec_balancer (noheartbeat)
[1015.090718] Starting subtest: noheartbeat
[1015.093827] Subtest noheartbeat: SKIP (0.000s)
[1015.197488] [121/133] ( 38s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[1015.247011] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[1015.357998] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[1015.490674] [122/133] ( 38s left) kms_big_fb (linear-addfb)
[1016.997658] Starting subtest: linear-addfb
[1016.999241] Subtest linear-addfb: SUCCESS (0.000s)
[1017.184497] [123/133] ( 36s left) perf_pmu (busy)
[1017.237396] Starting subtest: busy
[1017.238916] Starting dynamic subtest: rcs0
[1017.851025] Dynamic subtest rcs0: SUCCESS (0.614s)
[1017.868297] Starting dynamic subtest: bcs0
[1018.418033] Dynamic subtest bcs0: SUCCESS (0.561s)
[1018.435527] Starting dynamic subtest: vcs0
[1018.984023] Dynamic subtest vcs0: SUCCESS (0.560s)
[1019.001448] Starting dynamic subtest: vcs1
[1019.554100] Dynamic subtest vcs1: SUCCESS (0.564s)
[1019.570351] Starting dynamic subtest: vecs0
[1020.116446] Dynamic subtest vecs0: SUCCESS (0.557s)
[1020.120941] Subtest busy: SUCCESS (2.883s)
[1020.230977] [124/133] ( 33s left) kms_force_connector_basic (force-load-detect)
[1020.364008] Starting subtest: force-load-detect
[1020.366673] Subtest force-load-detect: SKIP (0.000s)
[1021.305134] [125/133] ( 32s left) gem_ctx_param (invalid-get-ringsize)
[1021.353493] Starting subtest: invalid-get-ringsize
[1021.355014] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[1021.472547] [126/133] ( 32s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[1022.966791] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[1022.969921] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[1023.144323] [127/133] ( 30s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[1024.636130] Starting subtest: cursorB-vs-flipA-varying-size
[1024.638962] Subtest cursorB-vs-flipA-varying-size: SKIP (0.003s)
[1024.754873] [128/133] ( 29s left) kms_flip (2x-blocking-wf_vblank)
[1026.251505] Starting subtest: 2x-blocking-wf_vblank
[1026.269470] Subtest 2x-blocking-wf_vblank: SKIP (0.017s)
[1026.423232] [129/133] ( 27s left) kms_plane_scaling (planes-downscale-factor-0-75)
[1027.924914] Starting subtest: planes-downscale-factor-0-75
[1027.926834] Starting dynamic subtest: pipe-A
[1028.029220] Dynamic subtest pipe-A: SUCCESS (0.104s)
[1028.043575] Starting dynamic subtest: pipe-B
[1028.169781] Dynamic subtest pipe-B: SUCCESS (0.139s)
[1028.185122] Starting dynamic subtest: pipe-C
[1028.310540] Dynamic subtest pipe-C: SUCCESS (0.139s)
[1028.322821] Starting dynamic subtest: pipe-D
[1028.450533] Dynamic subtest pipe-D: SUCCESS (0.138s)
[1028.452078] Subtest planes-downscale-factor-0-75: SUCCESS (0.527s)
[1028.625164] [130/133] ( 25s left) gem_exec_whisper (basic-fds-forked-all)
[1028.692932] Starting subtest: basic-fds-forked-all
[1040.524485] Subtest basic-fds-forked-all: SUCCESS (11.831s)
[1040.779275] [131/133] ( 13s left) kms_plane_lowres (tiling-none)
[1042.267630] Starting subtest: tiling-none
[1042.269329] Starting dynamic subtest: pipe-A-HDMI-A-4
[1051.724407] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.456s)
[1051.827113] Starting dynamic subtest: pipe-B-HDMI-A-4
[1061.046160] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (9.231s)
[1061.103414] Starting dynamic subtest: pipe-C-HDMI-A-4
[1070.332209] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (9.242s)
[1070.434356] Starting dynamic subtest: pipe-D-HDMI-A-4
[1079.643188] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.221s)
[1079.686487] Subtest tiling-none: SUCCESS (37.419s)
[1079.837629] Overall timeout time exceeded, stopping.
[1079.885238] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: sysfs_timeslice_duration
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: drm_buddy
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_wait
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_color_pipeline
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_selftest
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: testdisplay
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: i915_selftest
results: parsing output: 48/ for test: gem_partial_pwrite_pread
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: sw_sync
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: kms_dither
results: parsing output: 71/ for test: gem_madvise
results: parsing output: 72/ for test: kms_plane_alpha_blend
results: parsing output: 73/ for test: kms_pipe_b_c_ivb
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_nop
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_alignment
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: gem_ctx_exec
results: parsing output: 89/ for test: gem_busy
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_scaling_modes
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_exec_parallel
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_close_race
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_force_connector_basic
results: parsing output: 124/ for test: gem_ctx_param
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: kms_plane_lowres
results: parsing output: 131/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 132/ for test: prime_vgem
results: no output, setting notrun
Done.