[73.052332] Initializing watchdogs
[73.052414]   /dev/watchdog0
[73.082667] [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.097847] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[73.102821] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.106212] [001/133] (960s left) gem_exec_flush (basic-wb-prw-default)
[73.172783] Subtest basic-wb-prw-default: SKIP (0.000s)
[73.274572] [002/133] (960s left) gem_ctx_persistence (legacy-engines-hang)
[73.329322] Starting subtest: legacy-engines-hang
[73.330842] Starting dynamic subtest: render
[73.392712] Dynamic subtest render: SUCCESS (0.064s)
[73.401846] Starting dynamic subtest: bsd1
[73.481831] Dynamic subtest bsd1: SUCCESS (0.088s)
[73.495951] Starting dynamic subtest: bsd2
[73.499813] Dynamic subtest bsd2: SUCCESS (0.015s)
[73.513588] Starting dynamic subtest: blt
[73.573215] Dynamic subtest blt: SUCCESS (0.073s)
[73.603517] Starting dynamic subtest: vebox
[73.625837] Dynamic subtest vebox: SUCCESS (0.051s)
[73.627557] Subtest legacy-engines-hang: SUCCESS (0.298s)
[73.849563] [003/133] (959s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[73.906321] Starting subtest: y-tiled-to-vebox-yf-tiled
[73.907930] Starting dynamic subtest: smem
[73.992968] Dynamic subtest smem: SUCCESS (0.088s)
[74.001098] Starting dynamic subtest: lmem0
[74.752857] Dynamic subtest lmem0: SUCCESS (0.756s)
[74.754708] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.845s)
[74.991363] [004/133] (958s left) gem_create (create-invalid-size)
[75.037718] Starting subtest: create-invalid-size
[75.039357] Subtest create-invalid-size: SUCCESS (0.000s)
[75.291395] [005/133] (958s left) gem_exec_schedule (implicit-write-read)
[75.348988] Starting subtest: implicit-write-read
[75.350618] Starting dynamic subtest: rcs0
[75.555167] Dynamic subtest rcs0: SUCCESS (0.203s)
[75.563365] Starting dynamic subtest: bcs0
[75.689729] Dynamic subtest bcs0: SUCCESS (0.137s)
[75.698103] Starting dynamic subtest: vcs0
[75.828062] Dynamic subtest vcs0: SUCCESS (0.138s)
[75.836732] Starting dynamic subtest: vcs1
[75.977284] Dynamic subtest vcs1: SUCCESS (0.149s)
[75.985750] Starting dynamic subtest: vecs0
[76.127712] Dynamic subtest vecs0: SUCCESS (0.150s)
[76.129504] Subtest implicit-write-read: SUCCESS (0.778s)
[76.578997] [006/133] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[78.075396] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[78.078810] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[78.220509] [007/133] (955s left) api_intel_bb (render-ccs)
[78.279276] Starting subtest: render-ccs
[78.377361] Subtest render-ccs: SUCCESS (0.099s)
[78.492770] [008/133] (955s left) gem_eio (in-flight-internal-1us)
[78.705344] Starting subtest: in-flight-internal-1us
[79.845733] Subtest in-flight-internal-1us: SUCCESS (1.141s)
[81.433856] [009/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[82.946819] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[82.949692] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[83.114923] [010/133] (951s left) kms_feature_discovery (display-4x)
[84.610042] Starting subtest: display-4x
[84.613867] Subtest display-4x: SKIP (0.000s)
[84.713191] [011/133] (949s left) gem_busy (semaphore)
[84.978986] Subtest semaphore: SKIP (0.000s)
[85.276989] [012/133] (949s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[85.326512] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[85.402335] [013/133] (949s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[86.889272] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[86.892167] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[86.994933] [014/133] (947s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[88.494518] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[88.498031] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[88.672743] [015/133] (946s left) prime_mmap (test_refcounting)
[88.727239] Starting subtest: test_refcounting
[88.728680] Starting dynamic subtest: test_refcounting-smem
[88.791315] Dynamic subtest test_refcounting-smem: SUCCESS (0.065s)
[88.800388] Starting dynamic subtest: test_refcounting-lmem0
[88.857611] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.066s)
[88.859049] Subtest test_refcounting: SUCCESS (0.132s)
[88.982029] [016/133] (945s left) kms_addfb_basic (bad-pitch-0)
[89.028632] Starting subtest: bad-pitch-0
[89.030125] Subtest bad-pitch-0: SUCCESS (0.000s)
[90.631521] [017/133] (944s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[90.692946] Subtest writes-after-reads-snoop: SKIP (0.000s)
[90.795686] [018/133] (944s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[92.282958] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[92.284688] Starting dynamic subtest: pipe-A-HDMI-A-4
[92.303867] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[92.313238] Starting dynamic subtest: pipe-B-HDMI-A-4
[92.332629] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[92.344687] Starting dynamic subtest: pipe-C-HDMI-A-4
[92.374135] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[92.383262] Starting dynamic subtest: pipe-D-HDMI-A-4
[92.400298] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[92.403416] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[92.539382] [019/133] (942s left) vgem_slow (nohang)
[92.649198] Starting subtest: nohang
[102.987318] Subtest nohang: SUCCESS (10.337s)
[103.075364] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[103.078415] [020/133] (932s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[103.132275] Starting subtest: y-tiled-ccs-to-x-tiled
[103.133879] Starting dynamic subtest: smem
[103.222104] Dynamic subtest smem: SUCCESS (0.091s)
[103.231449] Starting dynamic subtest: lmem0
[104.153874] Dynamic subtest lmem0: SUCCESS (0.928s)
[104.155823] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (1.020s)
[104.433721] [021/133] (930s left) kms_vblank (query-forked-hang)
[105.930170] Starting subtest: query-forked-hang
[105.933792] Starting dynamic subtest: pipe-A-HDMI-A-4
[132.452612] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.519s)
[132.465168] Starting dynamic subtest: pipe-D-HDMI-A-4
[157.463044] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.007s)
[157.464455] Subtest query-forked-hang: SUCCESS (51.533s)
[157.642523] [022/133] (877s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[158.159102] Starting subtest: syncobj-timeline-invalid-flags
[158.161335] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.002s)
[158.501895] [023/133] (876s left) kms_big_fb (linear-16bpp-rotate-270)
[160.013837] Starting subtest: linear-16bpp-rotate-270
[160.120339] Subtest linear-16bpp-rotate-270: SKIP (0.104s)
[160.260239] [024/133] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[161.787746] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[161.791160] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[161.941727] [025/133] (873s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[163.437124] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[163.453812] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.017s)
[163.597692] [026/133] (872s left) kms_cursor_crc (cursor-onscreen-512x170)
[165.388169] Starting subtest: cursor-onscreen-512x170
[165.390718] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[165.601109] [027/133] (870s left) gem_exec_balancer (parallel-out-fence)
[165.969728] Starting subtest: parallel-out-fence
[168.377286] Subtest parallel-out-fence: SUCCESS (2.408s)
[168.489619] [028/133] (867s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[168.537534] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[168.539115] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[168.658048] [029/133] (867s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[170.151282] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[170.154123] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[170.308325] [030/133] (865s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[171.836447] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[172.443623] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.608s)
[172.685505] [031/133] (863s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[174.174458] Starting subtest: invalid-modeset-force-ultra-joiner
[174.179429] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[174.281605] [032/133] (861s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[175.931124] Starting subtest: cursor-rapid-movement-64x21
[175.938113] Starting dynamic subtest: pipe-A-HDMI-A-4
[176.366982] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.429s)
[176.399138] Starting dynamic subtest: pipe-D-HDMI-A-4
[176.725176] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.323s)
[176.726728] Subtest cursor-rapid-movement-64x21: SUCCESS (0.783s)
[177.176618] [033/133] (858s left) kms_lease (multimaster-lease)
[178.662161] Starting subtest: multimaster-lease
[178.667117] Subtest multimaster-lease: SUCCESS (0.004s)
[178.787022] [034/133] (857s left) kms_psr (psr2-cursor-mmap-gtt)
[180.286741] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[180.356463] [035/133] (855s left) gem_softpin (zero)
[180.408923] Starting subtest: zero
[180.415208] Subtest zero: SUCCESS (0.006s)
[180.599112] [036/133] (855s left) kms_atomic_transition (plane-all-modeset-transition)
[182.085064] Starting subtest: plane-all-modeset-transition
[182.086510] Starting dynamic subtest: pipe-A-HDMI-A-4
[193.736124] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (11.647s)
[193.789857] Starting dynamic subtest: pipe-B-HDMI-A-4
[201.794064] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (8.013s)
[201.809886] Subtest plane-all-modeset-transition: SUCCESS (19.725s)
[202.022873] [037/133] (834s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[203.515141] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[203.583638] [038/133] (832s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[205.070538] Starting subtest: primary-4-tiled-reflect-x-0
[205.173099] Subtest primary-4-tiled-reflect-x-0: SKIP (0.102s)
[205.385400] [039/133] (831s left) gem_ctx_isolation (clean)
[205.474378] Starting subtest: clean
[205.476055] Starting dynamic subtest: rcs0
[205.595691] Dynamic subtest rcs0: SUCCESS (0.121s)
[205.605762] Starting dynamic subtest: bcs0
[205.730382] Dynamic subtest bcs0: SUCCESS (0.135s)
[205.740177] Starting dynamic subtest: vcs0
[205.832716] Dynamic subtest vcs0: SUCCESS (0.102s)
[205.842590] Starting dynamic subtest: vcs1
[205.966241] Dynamic subtest vcs1: SUCCESS (0.134s)
[205.976212] Starting dynamic subtest: vecs0
[206.088274] Dynamic subtest vecs0: SUCCESS (0.122s)
[206.089899] Subtest clean: SUCCESS (0.614s)
[206.377170] [040/133] (830s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[207.870162] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[207.873166] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[208.058115] [041/133] (828s left) syncobj_timeline (etime-multi-wait-submitted)
[208.106635] Starting subtest: etime-multi-wait-submitted
[208.218258] Subtest etime-multi-wait-submitted: SUCCESS (0.108s)
[208.368484] [042/133] (828s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[209.857383] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[209.858895] Starting dynamic subtest: pipe-A-valid-mode
[211.083742] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.225s)
[211.085367] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.227s)
[211.263420] [043/133] (825s left) gen9_exec_parse (batch-invalid-length)
[211.316647] Subtest batch-invalid-length: SKIP (0.000s)
[211.390636] [044/133] (825s left) kms_big_fb (4-tiled-addfb)
[212.895875] Starting subtest: 4-tiled-addfb
[212.899407] Subtest 4-tiled-addfb: SKIP (0.000s)
[213.081501] [045/133] (824s left) gem_create (create-valid-nonaligned)
[213.139538] Starting subtest: create-valid-nonaligned
[213.140929] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[213.406088] [046/133] (823s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[213.453734] Starting subtest: single-wait-for-submit-available-signaled
[213.455163] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[213.572208] [047/133] (823s left) gem_fence_thrash (bo-copy)
[213.616544] Starting subtest: bo-copy
[213.623557] Subtest bo-copy: SKIP (0.002s)
[213.692424] [048/133] (823s left) i915_pm_sseu (full-enable)
[213.744728] Subtest full-enable: SKIP (0.000s)
[213.856381] [049/133] (823s left) kms_chamelium_color (gamma)
[215.343295] Subtest gamma: SKIP (0.000s)
[215.425415] [050/133] (822s left) kms_chamelium_hpd (hdmi-hpd-fast)
[216.958868] Subtest hdmi-hpd-fast: SKIP (0.000s)
[217.071556] [051/133] (820s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[220.984843] Starting subtest: modeset-lpsp-stress-no-wait
[221.060656] Subtest modeset-lpsp-stress-no-wait: SKIP (0.072s)
[221.903559] [052/133] (815s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[223.391661] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[224.430106] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.039s)
[224.609720] [053/133] (813s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[226.104167] Starting subtest: fbc-indfb-scaledprimary
[229.730101] Subtest fbc-indfb-scaledprimary: SUCCESS (3.629s)
[229.976469] [054/133] (807s left) gem_exec_parallel (basic)
[230.049824] Starting subtest: basic
[230.051325] Starting dynamic subtest: rcs0
[231.796433] Dynamic subtest rcs0: SUCCESS (1.746s)
[231.806182] Starting dynamic subtest: bcs0
[233.437430] Dynamic subtest bcs0: SUCCESS (1.640s)
[233.448019] Starting dynamic subtest: vcs0
[234.949410] Dynamic subtest vcs0: SUCCESS (1.511s)
[234.959836] Starting dynamic subtest: vcs1
[236.466467] Dynamic subtest vcs1: SUCCESS (1.516s)
[236.477233] Starting dynamic subtest: vecs0
[237.993600] Dynamic subtest vecs0: SUCCESS (1.526s)
[237.995190] Subtest basic: SUCCESS (7.944s)
[238.343465] [055/133] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[239.838378] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[239.841640] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[240.001696] [056/133] (798s left) kms_flip (blocking-wf_vblank)
[241.492612] Starting subtest: blocking-wf_vblank
[241.497891] Starting dynamic subtest: A-HDMI-A4
[249.675912] Dynamic subtest A-HDMI-A4: SUCCESS (8.178s)
[249.687655] Starting dynamic subtest: B-HDMI-A4
[257.806356] Dynamic subtest B-HDMI-A4: SUCCESS (8.129s)
[257.817220] Starting dynamic subtest: C-HDMI-A4
[265.941603] Dynamic subtest C-HDMI-A4: SUCCESS (8.135s)
[265.952012] Starting dynamic subtest: D-HDMI-A4
[274.076824] Dynamic subtest D-HDMI-A4: SUCCESS (8.134s)
[274.078430] Subtest blocking-wf_vblank: SUCCESS (32.587s)
[274.282295] [057/133] (763s left) gem_lmem_swapping (verify)
[278.501116] Starting subtest: verify
[278.503071] Starting dynamic subtest: lmem0
[318.724695] Dynamic subtest lmem0: SUCCESS (40.220s)
[318.726038] Subtest verify: SUCCESS (40.221s)
[320.140349] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[320.141503] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[320.145195] [058/133] (718s left) sysfs_timeslice_duration (idempotent)
[323.519341] Starting subtest: idempotent
[323.520901] Starting dynamic subtest: vecs0
[323.522452] Dynamic subtest vecs0: SUCCESS (0.001s)
[323.531341] Starting dynamic subtest: vcs0
[323.532876] Dynamic subtest vcs0: SUCCESS (0.002s)
[323.541463] Starting dynamic subtest: bcs0
[323.543076] Dynamic subtest bcs0: SUCCESS (0.001s)
[323.553130] Starting dynamic subtest: rcs0
[323.554692] Dynamic subtest rcs0: SUCCESS (0.001s)
[323.563661] Starting dynamic subtest: vcs1
[323.565267] Dynamic subtest vcs1: SUCCESS (0.001s)
[323.566796] Subtest idempotent: SUCCESS (0.010s)
[323.623106] [FACT sysfs_timeslice_duration (idempotent)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[323.626592] [FACT sysfs_timeslice_duration (idempotent)] new: kernel.kmod_is_loaded.i915: true
[323.630418] [059/133] (714s left) gem_exec_reloc (basic-softpin)
[323.691884] Subtest basic-softpin: SKIP (0.000s)
[323.792907] [060/133] (714s left) gem_close (basic)
[323.848761] Starting subtest: basic
[323.850875] Subtest basic: SUCCESS (0.000s)
[323.989602] [061/133] (714s left) gem_render_linear_blits (basic)
[324.040337] Starting subtest: basic
[324.124609] Subtest basic: SUCCESS (0.084s)
[324.243928] [062/133] (714s left) core_hotunplug (unbind-rebind)
[324.342454] Starting subtest: unbind-rebind
[329.907832] Subtest unbind-rebind: SUCCESS (5.567s)
[329.974745] [063/133] (708s left) kms_pipe_crc_basic (hang-read-crc)
[331.505374] Starting subtest: hang-read-crc
[331.506873] Starting dynamic subtest: pipe-A-HDMI-A-4
[332.877473] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.370s)
[332.889598] Starting dynamic subtest: pipe-B-HDMI-A-4
[334.120189] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.240s)
[334.130135] Starting dynamic subtest: pipe-C-HDMI-A-4
[335.386086] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.264s)
[335.397953] Starting dynamic subtest: pipe-D-HDMI-A-4
[336.654975] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.267s)
[336.656348] Subtest hang-read-crc: SUCCESS (5.150s)
[336.836640] [064/133] (701s left) kms_addfb_basic (tile-pitch-mismatch)
[336.883971] Starting subtest: tile-pitch-mismatch
[336.886862] Subtest tile-pitch-mismatch: SKIP (0.000s)
[338.540236] [065/133] (700s left) gem_exec_store (pages)
[338.599815] Starting subtest: pages
[338.601500] Starting dynamic subtest: rcs0
[338.746838] Dynamic subtest rcs0: SUCCESS (0.147s)
[338.757763] Starting dynamic subtest: bcs0
[338.863424] Dynamic subtest bcs0: SUCCESS (0.116s)
[338.873587] Starting dynamic subtest: vcs0
[338.988030] Dynamic subtest vcs0: SUCCESS (0.123s)
[338.997980] Starting dynamic subtest: vcs1
[339.099532] Dynamic subtest vcs1: SUCCESS (0.111s)
[339.109534] Starting dynamic subtest: vecs0
[339.210747] Dynamic subtest vecs0: SUCCESS (0.110s)
[339.212452] Subtest pages: SUCCESS (0.611s)
[339.495006] [066/133] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[340.991766] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[340.994574] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[341.175658] [067/133] (697s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[342.682234] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[343.791289] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.105s)
[343.989359] [068/133] (695s left) perf (polling)
[344.119781] Starting subtest: polling
[344.121376] Starting dynamic subtest: 0-rcs0
[354.161511] Dynamic subtest 0-rcs0: SUCCESS (10.039s)
[354.164157] Subtest polling: SUCCESS (10.040s)
[354.234315] [069/133] (684s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[354.283053] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[354.394925] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[354.620340] [070/133] (684s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[356.111238] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[356.180986] [071/133] (683s left) syncobj_wait (single-wait-all-submitted)
[356.229765] Starting subtest: single-wait-all-submitted
[356.336530] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[356.489010] [072/133] (682s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[357.982041] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[361.038237] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.058s)
[361.231387] [073/133] (678s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[362.720579] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[362.797703] [074/133] (676s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[364.288752] Starting subtest: plane-lut1d-ctm3x4
[364.489880] Starting dynamic subtest: pipe-A-plane-0
[364.738236] Dynamic subtest pipe-A-plane-0: SUCCESS (0.248s)
[364.777809] Starting dynamic subtest: pipe-A-plane-1
[364.954524] Dynamic subtest pipe-A-plane-1: SUCCESS (0.212s)
[364.983125] Starting dynamic subtest: pipe-A-plane-2
[365.154625] Dynamic subtest pipe-A-plane-2: SUCCESS (0.196s)
[365.436300] Starting dynamic subtest: pipe-B-plane-0
[365.601276] Dynamic subtest pipe-B-plane-0: SUCCESS (0.198s)
[365.635831] Starting dynamic subtest: pipe-B-plane-1
[365.801294] Dynamic subtest pipe-B-plane-1: SUCCESS (0.195s)
[365.836374] Starting dynamic subtest: pipe-B-plane-2
[366.017843] Dynamic subtest pipe-B-plane-2: SUCCESS (0.212s)
[366.308926] Starting dynamic subtest: pipe-C-plane-0
[366.494476] Dynamic subtest pipe-C-plane-0: SUCCESS (0.215s)
[366.532548] Starting dynamic subtest: pipe-C-plane-1
[366.711896] Dynamic subtest pipe-C-plane-1: SUCCESS (0.212s)
[366.738483] Starting dynamic subtest: pipe-C-plane-2
[366.912851] Dynamic subtest pipe-C-plane-2: SUCCESS (0.195s)
[367.217458] Starting dynamic subtest: pipe-D-plane-0
[367.388984] Dynamic subtest pipe-D-plane-0: SUCCESS (0.198s)
[367.417983] Starting dynamic subtest: pipe-D-plane-1
[367.589073] Dynamic subtest pipe-D-plane-1: SUCCESS (0.195s)
[367.617939] Starting dynamic subtest: pipe-D-plane-2
[367.805236] Dynamic subtest pipe-D-plane-2: SUCCESS (0.212s)
[367.860048] Subtest plane-lut1d-ctm3x4: SUCCESS (3.572s)
[368.038413] [075/133] (671s left) gem_eio (throttle)
[368.197524] Starting subtest: throttle
[368.428527] Subtest throttle: SUCCESS (0.232s)
[370.015409] [076/133] (669s left) perf_pmu (busy-start)
[370.074896] Starting subtest: busy-start
[370.076455] Starting dynamic subtest: rcs0
[372.639688] Dynamic subtest rcs0: SUCCESS (2.564s)
[372.652917] Starting dynamic subtest: bcs0
[375.187465] Dynamic subtest bcs0: SUCCESS (2.546s)
[375.200675] Starting dynamic subtest: vcs0
[377.735602] Dynamic subtest vcs0: SUCCESS (2.547s)
[377.749193] Starting dynamic subtest: vcs1
[380.283545] Dynamic subtest vcs1: SUCCESS (2.547s)
[380.296908] Starting dynamic subtest: vecs0
[382.830629] Dynamic subtest vecs0: SUCCESS (2.546s)
[382.832347] Subtest busy-start: SUCCESS (12.756s)
[382.949679] [077/133] (656s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[384.438026] Starting subtest: cursorA-vs-flipB-varying-size
[384.440927] Subtest cursorA-vs-flipB-varying-size: SKIP (0.002s)
[384.572480] [078/133] (655s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[386.091276] Starting subtest: y-tiled-64bpp-rotate-270
[386.164176] Subtest y-tiled-64bpp-rotate-270: SKIP (0.072s)
[386.332117] [079/133] (653s left) kms_psr (pr-primary-page-flip)
[387.820776] Subtest pr-primary-page-flip: SKIP (0.000s)
[387.901936] [080/133] (652s left) kms_cursor_legacy (torture-bo)
[389.389671] Starting subtest: torture-bo
[389.391102] Starting dynamic subtest: pipe-A
[394.898795] Dynamic subtest pipe-A: SUCCESS (5.509s)
[394.909989] Starting dynamic subtest: pipe-B
[400.452426] Dynamic subtest pipe-B: SUCCESS (5.549s)
[400.464153] Starting dynamic subtest: pipe-C
[405.946475] Dynamic subtest pipe-C: SUCCESS (5.496s)
[405.957579] Starting dynamic subtest: pipe-D
[411.431552] Dynamic subtest pipe-D: SUCCESS (5.480s)
[411.442935] Starting dynamic subtest: all-pipes
[416.923978] Dynamic subtest all-pipes: SUCCESS (5.492s)
[416.925774] Subtest torture-bo: SUCCESS (27.531s)
[417.079304] [081/133] (623s left) syncobj_wait (invalid-signal-illegal-handle)
[417.136214] Starting subtest: invalid-signal-illegal-handle
[417.137955] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[417.241443] [082/133] (623s left) i915_drm_fdinfo (busy)
[417.291921] Starting subtest: busy
[417.293831] Starting dynamic subtest: rcs0
[417.297113] Dynamic subtest rcs0: SKIP (0.000s)
[417.308777] Starting dynamic subtest: bcs0
[417.312366] Dynamic subtest bcs0: SKIP (0.000s)
[417.323636] Starting dynamic subtest: vcs0
[417.327462] Dynamic subtest vcs0: SKIP (0.000s)
[417.338852] Starting dynamic subtest: vcs1
[417.342565] Dynamic subtest vcs1: SKIP (0.000s)
[417.353433] Starting dynamic subtest: vecs0
[417.357047] Dynamic subtest vecs0: SKIP (0.000s)
[417.360955] Subtest busy: SKIP (0.007s)
[417.425025] [083/133] (622s left) kms_3d (basic)
[417.472785] Starting subtest: basic
[419.247125] Subtest basic: SUCCESS (1.773s)
[420.185533] [084/133] (620s left) gem_eio (context-create)
[420.351567] Starting subtest: context-create
[420.588553] Subtest context-create: SUCCESS (0.237s)
[422.166707] [085/133] (618s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[423.675399] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[423.678050] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[423.824031] [086/133] (616s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[425.319111] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[425.323842] Starting dynamic subtest: pipe-A
[426.138949] Dynamic subtest pipe-A: SUCCESS (0.820s)
[426.152245] Starting dynamic subtest: pipe-B
[426.895742] Dynamic subtest pipe-B: SUCCESS (0.755s)
[426.912276] Starting dynamic subtest: pipe-C
[427.669477] Dynamic subtest pipe-C: SUCCESS (0.772s)
[427.683306] Starting dynamic subtest: pipe-D
[428.426463] Dynamic subtest pipe-D: SUCCESS (0.756s)
[428.428055] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.109s)
[428.633810] [087/133] (612s left) drm_read (empty-block)
[430.185454] Starting subtest: empty-block
[431.187903] Subtest empty-block: SUCCESS (1.000s)
[431.388324] [088/133] (609s left) kms_plane (pixel-format-yf-tiled-modifier)
[432.875481] Starting subtest: pixel-format-yf-tiled-modifier
[432.878563] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[432.989345] [089/133] (607s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[434.483335] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[434.488494] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[434.667603] [090/133] (606s left) gem_exec_balancer (full-pulse)
[434.725419] Starting subtest: full-pulse
[437.200065] Subtest full-pulse: SUCCESS (2.475s)
[437.708832] [091/133] (603s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[439.203155] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[441.799621] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.598s)
[441.997866] [092/133] (599s left) gem_exec_flush (basic-wb-ro-default)
[442.051049] Subtest basic-wb-ro-default: SKIP (0.000s)
[442.179831] [093/133] (598s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[443.666742] Starting subtest: flip-vs-cursor-busy-crc-legacy
[444.387206] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.722s)
[444.568645] [094/133] (596s left) i915_getparams_basic (basic-eu-total)
[444.616281] Starting subtest: basic-eu-total
[444.619588] Subtest basic-eu-total: SUCCESS (0.000s)
[444.737642] [095/133] (596s left) syncobj_eventfd (binary-wait-signaled)
[444.785788] Starting subtest: binary-wait-signaled
[444.787517] Subtest binary-wait-signaled: SUCCESS (0.000s)
[444.903910] [096/133] (596s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[446.397388] Starting subtest: fbcpsr-rgb565-draw-render
[446.400624] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[446.573573] [097/133] (594s left) api_intel_allocator (two-level-inception)
[446.622773] Starting subtest: two-level-inception
[452.065515] Subtest two-level-inception: SUCCESS (5.438s)
[452.265733] [098/133] (589s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[453.765720] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[453.768784] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[453.945535] [099/133] (587s left) syncobj_wait (reset-signaled)
[453.996845] Starting subtest: reset-signaled
[453.998662] Subtest reset-signaled: SUCCESS (0.000s)
[454.124361] [100/133] (587s left) syncobj_timeline (multi-wait-available-submitted)
[454.171747] Starting subtest: multi-wait-available-submitted
[454.173390] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[454.304514] [101/133] (587s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[455.789045] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[455.790770] Starting dynamic subtest: pipe-A
[455.938165] Dynamic subtest pipe-A: SUCCESS (0.149s)
[455.949592] Starting dynamic subtest: pipe-B
[456.078633] Dynamic subtest pipe-B: SUCCESS (0.139s)
[456.089939] Starting dynamic subtest: pipe-C
[456.218703] Dynamic subtest pipe-C: SUCCESS (0.139s)
[456.230255] Starting dynamic subtest: pipe-D
[456.358797] Dynamic subtest pipe-D: SUCCESS (0.139s)
[456.360655] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.571s)
[456.566985] [102/133] (585s left) gem_mmap (pf-nonblock)
[456.616997] Subtest pf-nonblock: SKIP (0.000s)
[456.696537] [103/133] (585s left) gem_exec_reloc (basic-gtt-active)
[456.752427] Subtest basic-gtt-active: SKIP (0.000s)
[456.885901] [104/133] (585s left) kms_setmode (invalid-clone-single-crtc-stealing)
[456.934488] Starting subtest: invalid-clone-single-crtc-stealing
[456.939629] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[457.058704] [105/133] (585s left) kms_psr (fbc-psr2-suspend)
[458.555237] Subtest fbc-psr2-suspend: SKIP (0.000s)
[458.629903] [106/133] (583s left) perf (gen12-mi-rpc)
[458.760538] Starting subtest: gen12-mi-rpc
[458.762163] Starting dynamic subtest: rcs0
[458.806200] Dynamic subtest rcs0: SUCCESS (0.045s)
[458.807719] Subtest gen12-mi-rpc: SUCCESS (0.047s)
[458.884993] [107/133] (583s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[460.406508] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[460.409315] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[460.521772] [108/133] (581s left) prime_busy (after)
[460.578419] Starting subtest: after
[460.585431] Starting dynamic subtest: rcs0
[460.619423] Dynamic subtest rcs0: SUCCESS (0.034s)
[460.631141] Starting dynamic subtest: bcs0
[460.658645] Dynamic subtest bcs0: SUCCESS (0.038s)
[460.670464] Starting dynamic subtest: vcs0
[460.700113] Dynamic subtest vcs0: SUCCESS (0.040s)
[460.718769] Starting dynamic subtest: vcs1
[460.741554] Dynamic subtest vcs1: SUCCESS (0.039s)
[460.760153] Starting dynamic subtest: vecs0
[460.781892] Dynamic subtest vecs0: SUCCESS (0.038s)
[460.907383] Subtest after: SUCCESS (0.325s)
[461.069655] [109/133] (581s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[462.576712] Starting subtest: 4-tiled-16bpp-rotate-0
[462.579474] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[462.769712] [110/133] (579s left) gem_userptr_blits (probe)
[462.841962] Starting subtest: probe
[463.012027] Subtest probe: SUCCESS (0.167s)
[463.153922] [111/133] (579s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[464.641142] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[464.642585] Starting dynamic subtest: pipe-A-valid-mode
[465.810658] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.167s)
[465.811995] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.170s)
[465.992330] [112/133] (576s left) kms_content_protection (dp-mst-lic-type-1)
[467.537502] Starting subtest: dp-mst-lic-type-1
[467.540605] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[467.744306] [113/133] (575s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[469.236795] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[469.239720] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[469.421601] [114/133] (573s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[470.915880] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[470.919194] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[471.075925] [115/133] (572s left) gem_mmap_offset (bad-object)
[471.137166] Starting subtest: bad-object
[471.138838] Subtest bad-object: SUCCESS (0.001s)
[471.328905] [116/133] (571s left) gem_lmem_swapping (parallel-random-engines)
[475.528887] Starting subtest: parallel-random-engines
[475.530411] Starting dynamic subtest: lmem0
[505.185909] Dynamic subtest lmem0: SUCCESS (29.655s)
[505.187605] Subtest parallel-random-engines: SUCCESS (29.656s)
[506.072755] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[506.073916] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[506.076975] [117/133] (537s left) kms_psr (fbc-pr-sprite-render)
[510.835339] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[510.947511] [FACT kms_psr (fbc-pr-sprite-render)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[510.951540] [FACT kms_psr (fbc-pr-sprite-render)] new: kernel.kmod_is_loaded.i915: true
[510.955977] [118/133] (532s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[512.476639] Starting subtest: yf-tiled-8bpp-rotate-90
[512.479835] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[512.637912] [119/133] (530s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[514.146185] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[514.147600] Starting dynamic subtest: pipe-A-HDMI-A-4
[514.159972] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[514.170108] Starting dynamic subtest: pipe-B-HDMI-A-4
[514.185556] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[514.195778] Starting dynamic subtest: pipe-C-HDMI-A-4
[514.208573] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[514.218034] Starting dynamic subtest: pipe-D-HDMI-A-4
[514.231465] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[514.232979] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.014s)
[514.418135] [120/133] (529s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[515.908589] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[515.910153] Starting dynamic subtest: pipe-A-HDMI-A-4
[515.925953] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[515.936157] Starting dynamic subtest: pipe-B-HDMI-A-4
[515.952416] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[515.962484] Starting dynamic subtest: pipe-C-HDMI-A-4
[515.979108] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[515.988854] Starting dynamic subtest: pipe-D-HDMI-A-4
[516.003786] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[516.006388] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.011s)
[516.157680] [121/133] (527s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[517.646068] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[517.647843] Starting dynamic subtest: pipe-A-HDMI-A-4
[517.665514] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[517.676130] Starting dynamic subtest: pipe-B-HDMI-A-4
[517.705163] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[517.714571] Starting dynamic subtest: pipe-C-HDMI-A-4
[517.727249] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[517.736897] Starting dynamic subtest: pipe-D-HDMI-A-4
[517.750356] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[517.752957] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.014s)
[517.906934] [122/133] (525s left) gem_pxp (hw-rejects-pxp-context)
[520.485845] Starting subtest: hw-rejects-pxp-context
[520.487350] Subtest hw-rejects-pxp-context: SUCCESS (0.003s)
[520.591184] [123/133] (523s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[522.087394] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[522.090035] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[522.273183] [124/133] (521s left) gem_exec_fence (syncobj-timeline-unused-fence)
[522.843320] Starting subtest: syncobj-timeline-unused-fence
[522.865294] Subtest syncobj-timeline-unused-fence: SUCCESS (0.025s)
[523.162652] [125/133] (520s left) gem_exec_schedule (reorder-wide)
[523.345347] Subtest reorder-wide: SKIP (0.000s)
[523.619238] [126/133] (520s left) kms_sequence (get-forked)
[525.107105] Starting subtest: get-forked
[525.108686] Starting dynamic subtest: pipe-A-HDMI-A-4
[527.544470] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.436s)
[527.558385] Starting dynamic subtest: pipe-B-HDMI-A-4
[529.824788] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.278s)
[529.837498] Starting dynamic subtest: pipe-C-HDMI-A-4
[532.122495] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.295s)
[532.135167] Starting dynamic subtest: pipe-D-HDMI-A-4
[534.398866] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.272s)
[534.400508] Subtest get-forked: SUCCESS (9.291s)
[534.580222] [127/133] (509s left) i915_pm_rpm (sysfs-read)
[538.111394] Starting subtest: sysfs-read
[539.097083] Subtest sysfs-read: SUCCESS (0.988s)
[540.148025] [128/133] (504s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[541.645807] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[541.664648] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.018s)
[541.789106] [129/133] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[543.291610] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[543.295093] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[543.480100] [130/133] (500s left) kms_busy (basic)
[544.977158] Starting subtest: basic
[544.978959] Starting dynamic subtest: flip
[545.633749] Dynamic subtest flip: SUCCESS (0.656s)
[545.644438] Starting dynamic subtest: modeset
[546.339845] Dynamic subtest modeset: SUCCESS (0.705s)
[546.341534] Subtest basic: SUCCESS (1.366s)
[546.564028] [131/133] (497s left) kms_pm_rpm (fences)
[549.978511] Starting subtest: fences
[549.981763] Subtest fences: SKIP (0.000s)
[551.006899] [132/133] (493s left) gem_ctx_exec (basic-invalid-context)
[551.055860] Starting subtest: basic-invalid-context
[551.060831] Subtest basic-invalid-context: SUCCESS (0.005s)
[551.219077] [133/133] (493s left) kms_cursor_edge_walk (256x256-top-edge)
[552.707647] Starting subtest: 256x256-top-edge
[552.709532] Starting dynamic subtest: pipe-A-HDMI-A-4
[556.018043] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.311s)
[556.030765] Starting dynamic subtest: pipe-D-HDMI-A-4
[559.237504] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.216s)
[559.239051] Subtest 256x256-top-edge: SUCCESS (6.532s)
[559.416509] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_flush
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: gem_create
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_feature_discovery
results: parsing output: 10/ for test: gem_busy
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: prime_mmap
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: gem_partial_pwrite_pread
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: vgem_slow
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_joiner
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_lease
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: kms_atomic_transition
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: gem_ctx_isolation
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: gen9_exec_parse
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_create
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_fence_thrash
results: parsing output: 47/ for test: i915_pm_sseu
results: parsing output: 48/ for test: kms_chamelium_color
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_parallel
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: sysfs_timeslice_duration
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: gem_close
results: parsing output: 60/ for test: gem_render_linear_blits
results: parsing output: 61/ for test: core_hotunplug
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: gem_exec_store
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_color_pipeline
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: i915_drm_fdinfo
results: parsing output: 82/ for test: kms_3d
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: drm_read
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_flush
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: i915_getparams_basic
results: parsing output: 94/ for test: syncobj_eventfd
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: api_intel_allocator
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: gem_mmap
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_setmode
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: prime_busy
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_pxp
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_sequence
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_busy
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: gem_ctx_exec
results: parsing output: 132/ for test: kms_cursor_edge_walk
Done.