[67.623275] Initializing watchdogs
[67.623358]   /dev/watchdog0
[67.654653] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.669235] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.674387] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.677648] [001/133] (960s left) kms_chamelium_color (ctm-limited-range)
[69.179924] Subtest ctm-limited-range: SKIP (0.000s)
[69.260837] [002/133] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[70.832740] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[70.835653] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[71.029444] [003/133] (957s left) kms_selftest (drm_damage_helper)
[71.095055] Starting subtest: drm_damage_helper
[71.168178] Starting dynamic subtest: drm_test_damage_iter_no_damage
[71.881699] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.776s)
[71.890988] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[72.218847] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.335s)
[72.228228] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[72.281865] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.065s)
[72.302388] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[72.350473] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.069s)
[72.360890] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[72.424965] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.073s)
[72.438748] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[72.488984] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.064s)
[72.513385] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[72.563771] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.073s)
[72.573034] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[72.633392] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.069s)
[72.647203] Starting dynamic subtest: drm_test_damage_iter_single_damage
[72.703892] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.067s)
[72.742572] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[72.784290] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.079s)
[72.810919] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[72.863400] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.078s)
[72.901433] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[72.934191] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.071s)
[72.956685] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[73.015781] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.079s)
[73.051752] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[73.087589] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.073s)
[73.107438] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[73.161286] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.071s)
[73.199758] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[73.233554] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.072s)
[73.252161] Starting dynamic subtest: drm_test_damage_iter_damage
[73.316553] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.080s)
[73.355025] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[73.385420] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.071s)
[73.403749] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[73.454206] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.065s)
[73.491178] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[73.526868] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.073s)
[73.547307] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[73.609083] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.078s)
[73.611907] Subtest drm_damage_helper: SUCCESS (2.512s)
[73.862349] [004/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[75.359605] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[75.362887] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[75.516978] [005/133] (953s left) gem_exec_reloc (basic-gtt-wc-active)
[75.579079] Subtest basic-gtt-wc-active: SKIP (0.000s)
[75.670825] [006/133] (952s left) gem_exec_balancer (nohangcheck)
[76.105170] Starting subtest: nohangcheck
[78.188840] Subtest nohangcheck: SUCCESS (2.082s)
[78.343151] [007/133] (950s left) gem_exec_fence (keep-in-fence)
[78.520328] Starting subtest: keep-in-fence
[78.522060] Starting dynamic subtest: rcs0
[78.596055] Dynamic subtest rcs0: SUCCESS (0.076s)
[78.607212] Starting dynamic subtest: bcs0
[78.648799] Dynamic subtest bcs0: SUCCESS (0.052s)
[78.667065] Starting dynamic subtest: vcs0
[78.711924] Dynamic subtest vcs0: SUCCESS (0.062s)
[78.748268] Starting dynamic subtest: vcs1
[78.792808] Dynamic subtest vcs1: SUCCESS (0.081s)
[78.807547] Starting dynamic subtest: vecs0
[78.850141] Dynamic subtest vecs0: SUCCESS (0.057s)
[78.852346] Subtest keep-in-fence: SUCCESS (0.330s)
[79.508835] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[79.511391] [008/133] (949s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[81.002201] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[81.005859] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[81.139775] [009/133] (947s left) gem_mmap_gtt (basic-small-copy-xy)
[81.194537] Subtest basic-small-copy-XY: SKIP (0.000s)
[81.273118] [010/133] (947s left) gem_pwrite (basic-random)
[81.332453] Subtest basic-random: SKIP (0.000s)
[81.440420] [011/133] (947s left) kms_psr (fbc-psr-primary-blt)
[82.930936] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[83.005574] [012/133] (946s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[84.494946] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[84.498378] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[84.647527] [013/133] (944s left) gem_render_copy (linear-to-vebox-y-tiled)
[84.706449] Starting subtest: linear-to-vebox-y-tiled
[84.708173] Starting dynamic subtest: smem
[84.794935] Dynamic subtest smem: SUCCESS (0.088s)
[84.805036] Starting dynamic subtest: lmem0
[85.555646] Dynamic subtest lmem0: SUCCESS (0.757s)
[85.557557] Subtest linear-to-vebox-y-tiled: SUCCESS (0.846s)
[85.830390] [014/133] (943s left) api_intel_allocator (fork-simple-stress-signal)
[85.874440] Starting subtest: fork-simple-stress-signal
[91.313216] Subtest fork-simple-stress-signal: SUCCESS (5.435s)
[91.499876] [015/133] (937s left) gem_exec_whisper (basic-sync)
[91.592402] Starting subtest: basic-sync
[94.922693] Subtest basic-sync: SUCCESS (3.330s)
[95.173487] [016/133] (934s left) kms_content_protection (lic-type-0-hdcp14)
[96.720479] Starting subtest: lic-type-0-hdcp14
[96.726707] Subtest lic-type-0-hdcp14: SKIP (0.002s)
[96.891420] [017/133] (932s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[98.389183] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[98.412335] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.022s)
[98.618848] [018/133] (931s left) gem_exec_schedule (wide)
[98.796899] Starting subtest: wide
[98.798562] Starting dynamic subtest: rcs0
[114.056082] Dynamic subtest rcs0: SUCCESS (15.255s)
[114.067983] Starting dynamic subtest: bcs0
[129.571085] Dynamic subtest bcs0: SUCCESS (15.514s)
[129.584014] Starting dynamic subtest: vcs0
[145.493869] Dynamic subtest vcs0: SUCCESS (15.925s)
[145.504730] Starting dynamic subtest: vcs1
[161.722891] Dynamic subtest vcs1: SUCCESS (16.229s)
[161.733177] Starting dynamic subtest: vecs0
[177.739324] Dynamic subtest vecs0: SUCCESS (16.016s)
[177.740927] Subtest wide: SUCCESS (78.941s)
[179.627474] [019/133] (850s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[179.678399] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[179.780661] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[179.950699] [020/133] (849s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[181.440960] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[181.442584] Starting dynamic subtest: pipe-A-HDMI-A-1
[181.448701] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[181.459257] Starting dynamic subtest: pipe-B-HDMI-A-1
[181.465705] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[181.476032] Starting dynamic subtest: pipe-C-HDMI-A-1
[181.482307] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[181.492047] Starting dynamic subtest: pipe-D-HDMI-A-1
[181.498381] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[181.501644] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[181.704461] [021/133] (848s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[183.202604] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[183.206215] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[183.412180] [022/133] (846s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[184.905487] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[184.984646] [023/133] (845s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[186.500973] Starting subtest: yf-tiled-8bpp-rotate-180
[186.504544] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[186.674398] [024/133] (843s left) syncobj_wait (invalid-reset-bad-pad)
[186.724805] Starting subtest: invalid-reset-bad-pad
[186.726453] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[186.848843] [025/133] (843s left) kms_pm_lpsp (kms-lpsp)
[189.366742] Starting subtest: kms-lpsp
[189.370316] Subtest kms-lpsp: SKIP (0.000s)
[189.504429] [026/133] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[191.023840] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[191.027217] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[191.256901] [027/133] (839s left) kms_pm_rpm (pc8-residency)
[195.018356] Starting subtest: pc8-residency
[195.021651] Subtest pc8-residency: SKIP (0.000s)
[195.965326] [028/133] (834s left) syncobj_timeline (single-wait-available-signaled)
[196.015744] Starting subtest: single-wait-available-signaled
[196.017506] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[196.145022] [029/133] (834s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[197.645491] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[197.648964] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[197.809953] [030/133] (833s left) kms_hdr (static-toggle)
[199.300835] Starting subtest: static-toggle
[199.305595] Subtest static-toggle: SKIP (0.000s)
[199.451324] [031/133] (831s left) kms_cursor_crc (cursor-sliding-128x128)
[201.120299] Starting subtest: cursor-sliding-128x128
[201.125659] Starting dynamic subtest: pipe-A-HDMI-A-1
[205.552474] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.426s)
[205.585752] Starting dynamic subtest: pipe-D-HDMI-A-1
[209.934182] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.357s)
[209.935981] Subtest cursor-sliding-128x128: SUCCESS (8.813s)
[210.345428] [032/133] (820s left) gem_exec_schedule (preempt-other-chain)
[210.408903] Starting subtest: preempt-other-chain
[210.410521] Starting dynamic subtest: rcs0
[210.564966] Dynamic subtest rcs0: SUCCESS (0.154s)
[210.575456] Starting dynamic subtest: bcs0
[210.703116] Dynamic subtest bcs0: SUCCESS (0.137s)
[210.713503] Starting dynamic subtest: vcs0
[210.841724] Dynamic subtest vcs0: SUCCESS (0.138s)
[210.852031] Starting dynamic subtest: vcs1
[210.981355] Dynamic subtest vcs1: SUCCESS (0.139s)
[210.991837] Starting dynamic subtest: vecs0
[211.124239] Dynamic subtest vecs0: SUCCESS (0.142s)
[211.125889] Subtest preempt-other-chain: SUCCESS (0.712s)
[211.515101] [033/133] (819s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[213.013029] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[216.078719] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.067s)
[216.331187] [034/133] (814s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[217.830864] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[217.834569] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[218.016721] [035/133] (813s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[219.528027] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[220.778697] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.250s)
[221.014730] [036/133] (810s left) kms_vblank (wait-busy-hang)
[222.504979] Starting subtest: wait-busy-hang
[222.506623] Starting dynamic subtest: pipe-A-HDMI-A-1
[249.450927] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (26.943s)
[249.465091] Starting dynamic subtest: pipe-D-HDMI-A-1
[274.456096] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (25.003s)
[274.457720] Subtest wait-busy-hang: SUCCESS (51.952s)
[274.635652] [037/133] (756s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[276.126363] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[276.127858] Starting dynamic subtest: pipe-A
[276.280011] Dynamic subtest pipe-A: SUCCESS (0.153s)
[276.295267] Starting dynamic subtest: pipe-B
[276.439370] Dynamic subtest pipe-B: SUCCESS (0.159s)
[276.449777] Starting dynamic subtest: pipe-C
[276.580515] Dynamic subtest pipe-C: SUCCESS (0.141s)
[276.591091] Starting dynamic subtest: pipe-D
[276.721141] Dynamic subtest pipe-D: SUCCESS (0.140s)
[276.722831] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.595s)
[276.909393] [038/133] (754s left) kms_psr (psr-cursor-render)
[278.403046] Subtest psr-cursor-render: SKIP (0.000s)
[278.493853] [039/133] (753s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[279.991287] Starting subtest: bad-pixel-format-y-tiled-ccs
[279.992937] Starting dynamic subtest: pipe-A-HDMI-A-1
[280.009834] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[280.020932] Starting dynamic subtest: pipe-B-HDMI-A-1
[280.037977] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[280.048619] Starting dynamic subtest: pipe-C-HDMI-A-1
[280.062417] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[280.072791] Starting dynamic subtest: pipe-D-HDMI-A-1
[280.087382] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[280.090042] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[280.238836] [040/133] (751s left) perf (missing-sample-flags)
[280.378418] Starting subtest: missing-sample-flags
[280.380054] Subtest missing-sample-flags: SUCCESS (0.000s)
[280.454503] [041/133] (751s left) kms_flip (flip-vs-panning-vs-hang)
[281.953814] Starting subtest: flip-vs-panning-vs-hang
[281.955351] Starting dynamic subtest: A-HDMI-A1
[333.453910] Dynamic subtest A-HDMI-A1: SUCCESS (51.500s)
[333.464882] Starting dynamic subtest: D-HDMI-A1
[383.434408] Dynamic subtest D-HDMI-A1: SUCCESS (49.980s)
[383.437768] Subtest flip-vs-panning-vs-hang: SUCCESS (101.485s)
[383.640219] [042/133] (648s left) kms_getfb (getfb2-handle-protection)
[385.131439] Starting subtest: getfb2-handle-protection
[385.174121] Subtest getfb2-handle-protection: SUCCESS (0.042s)
[385.414520] [043/133] (646s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[386.913730] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[386.917223] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[387.099931] [044/133] (645s left) vgem_basic (bad-pad)
[387.174797] Starting subtest: bad-pad
[387.176637] Subtest bad-pad: SUCCESS (0.000s)
[387.293874] [045/133] (644s left) kms_legacy_colorkey (basic)
[388.786192] Starting subtest: basic
[388.787858] Starting dynamic subtest: pipe-A
[388.873130] Dynamic subtest pipe-A: SUCCESS (0.088s)
[388.898805] Starting dynamic subtest: pipe-B
[388.901089] Dynamic subtest pipe-B: SUCCESS (0.001s)
[388.948300] Starting dynamic subtest: pipe-C
[388.951135] Dynamic subtest pipe-C: SUCCESS (0.001s)
[388.999210] Starting dynamic subtest: pipe-D
[389.001413] Dynamic subtest pipe-D: SUCCESS (0.002s)
[389.003443] Subtest basic: SUCCESS (0.096s)
[389.076281] [046/133] (643s left) kms_chamelium_hpd (vga-hpd)
[390.614770] Subtest vga-hpd: SKIP (0.000s)
[390.731845] [047/133] (641s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[390.781761] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[390.888391] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[391.054694] [048/133] (641s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[392.551469] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[392.553057] Starting dynamic subtest: pipe-A-HDMI-A-1
[392.594972] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[392.605816] Starting dynamic subtest: pipe-B-HDMI-A-1
[392.644960] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[392.655348] Starting dynamic subtest: pipe-C-HDMI-A-1
[392.689734] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[392.700048] Starting dynamic subtest: pipe-D-HDMI-A-1
[392.740153] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.003s)
[392.743584] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.016s)
[392.817065] [049/133] (639s left) gem_vm_create (isolation)
[392.871210] Starting subtest: isolation
[392.882354] Subtest isolation: SUCCESS (0.011s)
[393.051519] [050/133] (639s left) gem_partial_pwrite_pread (writes-after-reads-display)
[393.105948] Subtest writes-after-reads-display: SKIP (0.000s)
[393.218284] [051/133] (639s left) i915_drm_fdinfo (all-busy-check-all)
[393.270366] Starting subtest: all-busy-check-all
[393.288705] Subtest all-busy-check-all: SKIP (0.017s)
[393.394306] [052/133] (639s left) kms_flip (flip-vs-blocking-wf-vblank)
[394.928297] Starting subtest: flip-vs-blocking-wf-vblank
[394.932445] Starting dynamic subtest: A-HDMI-A1
[402.955367] Dynamic subtest A-HDMI-A1: SUCCESS (8.014s)
[402.965850] Starting dynamic subtest: B-HDMI-A1
[410.909144] Dynamic subtest B-HDMI-A1: SUCCESS (7.962s)
[410.920748] Starting dynamic subtest: C-HDMI-A1
[418.876877] Dynamic subtest C-HDMI-A1: SUCCESS (7.967s)
[418.888342] Starting dynamic subtest: D-HDMI-A1
[426.843975] Dynamic subtest D-HDMI-A1: SUCCESS (7.966s)
[426.847331] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.921s)
[427.067236] [053/133] (605s left) kms_chamelium_frames (dp-crc-fast)
[428.610150] Subtest dp-crc-fast: SKIP (0.000s)
[428.730105] [054/133] (604s left) kms_psr (pr-suspend)
[430.222210] Subtest pr-suspend: SKIP (0.000s)
[430.401644] [055/133] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[431.900694] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[431.903895] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[432.086212] [056/133] (601s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[433.580338] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[433.660315] [057/133] (599s left) gem_exec_endless (dispatch)
[433.738732] Starting subtest: dispatch
[433.740287] Starting dynamic subtest: rcs0
[433.749223] Dynamic subtest rcs0: SUCCESS (0.009s)
[433.760383] Starting dynamic subtest: bcs0
[433.763456] Dynamic subtest bcs0: SUCCESS (0.009s)
[433.774382] Starting dynamic subtest: vcs0
[433.777460] Dynamic subtest vcs0: SUCCESS (0.007s)
[433.790915] Starting dynamic subtest: vcs1
[433.794488] Dynamic subtest vcs1: SUCCESS (0.007s)
[433.805012] Starting dynamic subtest: vecs0
[433.808461] Dynamic subtest vecs0: SUCCESS (0.007s)
[433.810210] Subtest dispatch: SUCCESS (0.043s)
[433.957580] [058/133] (599s left) i915_query (query-topology-matches-eu-total)
[434.006632] Starting subtest: query-topology-matches-eu-total
[434.008229] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[434.150590] [059/133] (599s left) perf_pmu (busy-accuracy-2)
[434.219430] Starting subtest: busy-accuracy-2
[434.221247] Starting dynamic subtest: rcs0
[437.275152] Dynamic subtest rcs0: SUCCESS (3.054s)
[437.287130] Starting dynamic subtest: bcs0
[440.333914] Dynamic subtest bcs0: SUCCESS (3.058s)
[440.345966] Starting dynamic subtest: vcs0
[443.392953] Dynamic subtest vcs0: SUCCESS (3.058s)
[443.405044] Starting dynamic subtest: vcs1
[446.446992] Dynamic subtest vcs1: SUCCESS (3.053s)
[446.459637] Starting dynamic subtest: vecs0
[449.504072] Dynamic subtest vecs0: SUCCESS (3.056s)
[449.506032] Subtest busy-accuracy-2: SUCCESS (15.284s)
[449.698609] [060/133] (583s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[451.192968] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[451.194845] Starting dynamic subtest: pipe-A-valid-mode
[452.407792] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.214s)
[452.409644] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.215s)
[452.595420] [061/133] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[454.094670] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[454.097779] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[454.282690] [062/133] (579s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[455.774690] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[455.776313] Starting dynamic subtest: pipe-A-HDMI-A-1
[455.857639] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.084s)
[455.924099] Starting dynamic subtest: pipe-B-HDMI-A-1
[456.088380] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.174s)
[456.127710] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.354s)
[456.300578] [063/133] (577s left) kms_addfb_basic (bad-pitch-32)
[456.351258] Starting subtest: bad-pitch-32
[456.352962] Subtest bad-pitch-32: SUCCESS (0.000s)
[457.990334] [064/133] (575s left) kms_flip (basic-flip-vs-wf_vblank)
[459.482279] Starting subtest: basic-flip-vs-wf_vblank
[459.486790] Starting dynamic subtest: A-HDMI-A1
[460.516619] Dynamic subtest A-HDMI-A1: SUCCESS (1.030s)
[460.531801] Starting dynamic subtest: B-HDMI-A1
[461.645902] Dynamic subtest B-HDMI-A1: SUCCESS (1.128s)
[461.658316] Starting dynamic subtest: C-HDMI-A1
[462.780574] Dynamic subtest C-HDMI-A1: SUCCESS (1.133s)
[462.793116] Starting dynamic subtest: D-HDMI-A1
[463.911282] Dynamic subtest D-HDMI-A1: SUCCESS (1.129s)
[463.915069] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.433s)
[464.118729] [065/133] (569s left) core_getclient (basic)
[464.177481] Starting subtest: basic
[464.178909] Subtest basic: SUCCESS (0.000s)
[464.291989] [066/133] (569s left) gem_eio (wait-1us)
[464.484111] Starting subtest: wait-1us
[464.926140] Subtest wait-1us: SUCCESS (0.443s)
[466.513132] [067/133] (567s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[468.018382] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[468.021542] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[468.212807] [068/133] (566s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[469.703323] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[469.725523] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.021s)
[469.890652] [069/133] (564s left) gem_tiling_max_stride
[470.015748] [070/133] (564s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[471.509837] Starting subtest: cursorB-vs-flipA-legacy
[471.513651] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[471.657397] [071/133] (562s left) kms_plane (plane-position-hole-dpms)
[473.158712] Starting subtest: plane-position-hole-dpms
[473.591170] Starting dynamic subtest: pipe-A-plane-1
[474.058927] Dynamic subtest pipe-A-plane-1: SUCCESS (0.469s)
[474.072198] Starting dynamic subtest: pipe-A-plane-2
[474.545750] Dynamic subtest pipe-A-plane-2: SUCCESS (0.486s)
[474.558464] Starting dynamic subtest: pipe-A-plane-3
[475.005092] Dynamic subtest pipe-A-plane-3: SUCCESS (0.457s)
[475.018141] Starting dynamic subtest: pipe-A-plane-4
[475.477630] Dynamic subtest pipe-A-plane-4: SUCCESS (0.472s)
[475.490150] Starting dynamic subtest: pipe-A-plane-5
[475.948984] Dynamic subtest pipe-A-plane-5: SUCCESS (0.471s)
[475.961590] Starting dynamic subtest: pipe-A-plane-6
[476.420829] Dynamic subtest pipe-A-plane-6: SUCCESS (0.470s)
[476.433982] Starting dynamic subtest: pipe-A-plane-7
[476.443824] Dynamic subtest pipe-A-plane-7: SUCCESS (0.021s)
[476.735998] Starting dynamic subtest: pipe-B-plane-1
[477.175845] Dynamic subtest pipe-B-plane-1: SUCCESS (0.452s)
[477.188670] Starting dynamic subtest: pipe-B-plane-2
[477.617355] Dynamic subtest pipe-B-plane-2: SUCCESS (0.439s)
[477.630423] Starting dynamic subtest: pipe-B-plane-3
[478.056792] Dynamic subtest pipe-B-plane-3: SUCCESS (0.439s)
[478.070104] Starting dynamic subtest: pipe-B-plane-4
[478.477980] Dynamic subtest pipe-B-plane-4: SUCCESS (0.419s)
[478.491371] Starting dynamic subtest: pipe-B-plane-5
[478.906502] Dynamic subtest pipe-B-plane-5: SUCCESS (0.426s)
[478.920744] Starting dynamic subtest: pipe-B-plane-6
[479.360738] Dynamic subtest pipe-B-plane-6: SUCCESS (0.454s)
[479.373564] Starting dynamic subtest: pipe-B-plane-7
[479.386458] Dynamic subtest pipe-B-plane-7: SUCCESS (0.023s)
[479.387842] Subtest plane-position-hole-dpms: SUCCESS (6.228s)
[479.580521] [072/133] (555s left) i915_module_load (reload)
[479.631934] Starting subtest: reload
[483.971036] Subtest reload: SUCCESS (4.340s)
[484.073409] [073/133] (550s left) vgem_basic (sysfs)
[484.143287] Starting subtest: sysfs
[484.145290] Subtest sysfs: SUCCESS (0.001s)
[484.247914] [074/133] (550s left) i915_pm_rpm (gem-idle)
[488.093639] Starting subtest: gem-idle
[494.049647] Subtest gem-idle: SUCCESS (5.965s)
[494.919012] [075/133] (540s left) gem_readwrite (read-write)
[494.972529] Subtest read-write: SKIP (0.000s)
[495.088510] [076/133] (539s left) gem_lmem_swapping (verify-random)
[499.407261] Starting subtest: verify-random
[499.409460] Starting dynamic subtest: lmem0
[508.826494] Dynamic subtest lmem0: SUCCESS (9.415s)
[508.828154] Subtest verify-random: SUCCESS (9.418s)
[509.765032] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[509.766121] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[509.769509] [077/133] (525s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[514.550954] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[514.667075] [FACT kms_psr (fbc-psr2-cursor-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[514.671241] [FACT kms_psr (fbc-psr2-cursor-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[514.677138] [078/133] (520s left) gem_ctx_engines (invalid-engines)
[514.755166] Starting subtest: invalid-engines
[514.786663] Subtest invalid-engines: SUCCESS (0.031s)
[515.081596] [079/133] (520s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[516.574023] Starting subtest: fbc-dirtyfb-ioctl
[516.575772] Starting dynamic subtest: A-HDMI-A-1
[518.035404] Dynamic subtest A-HDMI-A-1: SUCCESS (1.461s)
[518.036919] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.463s)
[518.214982] [080/133] (517s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[518.267213] Starting subtest: invalid-single-wait-unsubmitted
[518.268846] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[518.383946] [081/133] (516s left) i915_pm_rps (waitboost)
[518.442403] Starting subtest: waitboost
[522.039171] Subtest waitboost: SUCCESS (3.597s)
[522.232075] [082/133] (513s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[523.725783] Starting subtest: 2x-long-flip-vs-cursor-atomic
[523.728877] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[523.887781] [083/133] (511s left) kms_draw_crc (draw-method-pwrite)
[525.381794] Starting subtest: draw-method-pwrite
[525.383435] Starting dynamic subtest: xrgb8888-untiled
[525.895574] Dynamic subtest xrgb8888-untiled: SUCCESS (0.513s)
[525.910873] Starting dynamic subtest: rgb565-untiled
[526.363768] Dynamic subtest rgb565-untiled: SUCCESS (0.465s)
[526.411346] Starting dynamic subtest: xrgb2101010-untiled
[526.845164] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.475s)
[526.859268] Starting dynamic subtest: xbgr16161616f-untiled
[527.332768] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.482s)
[527.369106] Starting dynamic subtest: xrgb8888-xtiled
[528.013470] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.676s)
[528.029674] Starting dynamic subtest: rgb565-xtiled
[528.711961] Dynamic subtest rgb565-xtiled: SUCCESS (0.694s)
[528.726497] Starting dynamic subtest: xrgb2101010-xtiled
[529.345313] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.631s)
[529.357671] Starting dynamic subtest: xbgr16161616f-xtiled
[530.111903] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.765s)
[530.124691] Starting dynamic subtest: xrgb8888-ytiled
[530.761989] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.648s)
[530.774481] Starting dynamic subtest: rgb565-ytiled
[531.212196] Dynamic subtest rgb565-ytiled: SUCCESS (0.448s)
[531.227120] Starting dynamic subtest: xrgb2101010-ytiled
[531.845483] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.631s)
[531.857871] Starting dynamic subtest: xbgr16161616f-ytiled
[532.862058] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (1.015s)
[532.863794] Subtest draw-method-pwrite: SUCCESS (7.482s)
[533.057498] [084/133] (502s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[534.570053] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[534.571781] Starting dynamic subtest: pipe-A-HDMI-A-1
[534.588591] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[534.600515] Starting dynamic subtest: pipe-B-HDMI-A-1
[534.617775] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[534.629334] Starting dynamic subtest: pipe-C-HDMI-A-1
[534.647364] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[534.659376] Starting dynamic subtest: pipe-D-HDMI-A-1
[534.678797] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[534.682557] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.013s)
[534.824823] [085/133] (500s left) gen9_exec_parse (batch-zero-length)
[534.880036] Subtest batch-zero-length: SKIP (0.000s)
[534.953496] [086/133] (500s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[536.454628] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[538.933045] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (2.482s)
[539.140352] [087/133] (496s left) syncobj_wait (invalid-signal-bad-pad)
[539.191523] Starting subtest: invalid-signal-bad-pad
[539.193277] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[539.320938] [088/133] (496s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[540.836828] Starting subtest: cursorB-vs-flipA-atomic
[540.840166] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[540.994179] [089/133] (495s left) prime_vgem (fence-read-hang)
[541.083547] Subtest fence-read-hang: SKIP (0.000s)
[541.245641] [090/133] (494s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[542.756884] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[542.760872] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[542.966283] [091/133] (493s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[543.016933] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[543.018353] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[543.142789] [092/133] (493s left) gem_userptr_blits (create-destroy-sync)
[543.205467] Starting subtest: create-destroy-sync
[548.219885] Subtest create-destroy-sync: SUCCESS (5.011s)
[548.399142] [093/133] (488s left) gem_exec_schedule (u-fairslice)
[548.459843] Starting subtest: u-fairslice
[548.461384] Starting dynamic subtest: rcs0
[550.500524] Dynamic subtest rcs0: SUCCESS (2.038s)
[550.512931] Starting dynamic subtest: bcs0
[552.521755] Dynamic subtest bcs0: SUCCESS (2.020s)
[552.534306] Starting dynamic subtest: vcs0
[554.543604] Dynamic subtest vcs0: SUCCESS (2.019s)
[554.555855] Starting dynamic subtest: vcs1
[556.565710] Dynamic subtest vcs1: SUCCESS (2.020s)
[556.577922] Starting dynamic subtest: vecs0
[558.585869] Dynamic subtest vecs0: SUCCESS (2.019s)
[558.587660] Subtest u-fairslice: SUCCESS (10.125s)
[558.961581] [094/133] (477s left) kms_cursor_crc (cursor-sliding-32x32)
[560.539376] Starting subtest: cursor-sliding-32x32
[560.594075] Subtest cursor-sliding-32x32: SKIP (0.051s)
[561.063076] [095/133] (475s left) gem_ctx_shared (detached-shared-gtt)
[561.124655] Starting subtest: detached-shared-gtt
[563.276599] Subtest detached-shared-gtt: SUCCESS (2.151s)
[564.398667] [096/133] (472s left) kms_big_fb (linear-8bpp-rotate-90)
[565.909401] Starting subtest: linear-8bpp-rotate-90
[566.015091] Subtest linear-8bpp-rotate-90: SKIP (0.103s)
[566.161574] [097/133] (470s left) kms_big_fb (x-tiled-addfb-size-overflow)
[567.674504] Starting subtest: x-tiled-addfb-size-overflow
[567.675989] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[567.856282] [098/133] (469s left) gem_userptr_blits (sync-unmap)
[567.920699] Starting subtest: sync-unmap
[567.944975] Subtest sync-unmap: SUCCESS (0.022s)
[568.135927] [099/133] (468s left) gem_exec_reloc (basic-cpu-read)
[568.190390] Subtest basic-cpu-read: SKIP (0.000s)
[568.292697] [100/133] (468s left) gem_exec_flush (basic-wb-set-default)
[568.347846] Subtest basic-wb-set-default: SKIP (0.000s)
[568.457677] [101/133] (468s left) kms_psr (psr-primary-mmap-gtt)
[569.961964] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[570.039668] [102/133] (467s left) kms_async_flips (async-flip-dpms)
[571.531727] Starting subtest: async-flip-dpms
[571.797120] Starting dynamic subtest: pipe-A-HDMI-A-1
[574.540487] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.744s)
[575.525926] Starting dynamic subtest: pipe-B-HDMI-A-1
[577.649189] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.137s)
[577.923358] Starting dynamic subtest: pipe-C-HDMI-A-1
[580.034740] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.127s)
[580.304015] Starting dynamic subtest: pipe-D-HDMI-A-1
[582.413462] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.129s)
[582.415082] Subtest async-flip-dpms: SUCCESS (10.884s)
[582.849922] [103/133] (454s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[584.362896] Starting subtest: y-tiled-64bpp-rotate-0
[587.016151] Subtest y-tiled-64bpp-rotate-0: SUCCESS (2.654s)
[587.256586] [104/133] (450s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[588.753049] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[588.927316] [105/133] (448s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[590.449813] Starting subtest: x-tiled-16bpp-rotate-90
[590.540831] Subtest x-tiled-16bpp-rotate-90: SKIP (0.099s)
[590.683884] [106/133] (447s left) gem_exec_params (larger-than-life-batch)
[590.771875] Starting subtest: larger-than-life-batch
[601.786144] Subtest larger-than-life-batch: SUCCESS (11.011s)
[602.442085] [107/133] (435s left) sriov_basic (enable-vfs-autoprobe-off)
[602.536738] Subtest enable-vfs-autoprobe-off: SKIP (0.000s)
[602.615728] [108/133] (435s left) kms_plane_cursor (overlay)
[604.114869] Starting subtest: overlay
[604.118169] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[607.332957] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (3.218s)
[607.414240] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[610.583247] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (3.182s)
[610.673836] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[613.916334] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (3.265s)
[614.019645] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[617.180416] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (3.173s)
[617.249335] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[620.398034] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (3.166s)
[620.463197] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[623.563625] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (3.116s)
[623.651761] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[626.797919] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (3.158s)
[626.862899] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[629.947943] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (3.099s)
[630.012866] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[633.031153] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (3.033s)
[633.121717] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[636.236584] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (3.129s)
[636.300475] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[639.552896] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (3.266s)
[639.621437] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[642.703527] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (3.099s)
[642.795603] Subtest overlay: SUCCESS (38.681s)
[643.035098] [109/133] (394s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[644.539758] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[644.543457] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[644.786663] [110/133] (393s left) gem_ccs (block-multicopy-inplace)
[644.861871] Starting subtest: block-multicopy-inplace
[644.864856] Subtest block-multicopy-inplace: SKIP (0.000s)
[645.018596] [111/133] (393s left) gem_ctx_sseu (invalid-args)
[645.072484] Subtest invalid-args: SKIP (0.000s)
[645.147746] [112/133] (393s left) kms_properties (plane-properties-legacy)
[646.641416] Starting subtest: plane-properties-legacy
[646.642798] Starting dynamic subtest: pipe-A-HDMI-A-1
[647.123469] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.481s)
[647.136675] Starting dynamic subtest: pipe-B-HDMI-A-1
[647.567203] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.442s)
[647.583196] Starting dynamic subtest: pipe-C-HDMI-A-1
[648.019330] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.449s)
[648.033313] Starting dynamic subtest: pipe-D-HDMI-A-1
[648.456113] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.436s)
[648.457669] Subtest plane-properties-legacy: SUCCESS (1.817s)
[648.637276] [113/133] (389s left) gem_partial_pwrite_pread (reads-snoop)
[648.693735] Subtest reads-snoop: SKIP (0.000s)
[648.800952] [114/133] (389s left) kms_fbcon_fbt (fbc-suspend)
[648.866486] Starting subtest: fbc-suspend
[705.194074] Subtest fbc-suspend: SUCCESS (33.988s)
[706.301864] [115/133] (333s left) kms_color_pipeline (plane-lut1d-lut1d)
[707.801158] Starting subtest: plane-lut1d-lut1d
[707.997781] Starting dynamic subtest: pipe-A-plane-0
[708.260292] Dynamic subtest pipe-A-plane-0: SUCCESS (0.263s)
[708.301830] Starting dynamic subtest: pipe-A-plane-1
[708.477322] Dynamic subtest pipe-A-plane-1: SUCCESS (0.212s)
[708.507999] Starting dynamic subtest: pipe-A-plane-2
[708.677533] Dynamic subtest pipe-A-plane-2: SUCCESS (0.194s)
[708.975580] Starting dynamic subtest: pipe-B-plane-0
[709.125623] Dynamic subtest pipe-B-plane-0: SUCCESS (0.182s)
[709.164901] Starting dynamic subtest: pipe-B-plane-1
[709.339751] Dynamic subtest pipe-B-plane-1: SUCCESS (0.209s)
[709.376945] Starting dynamic subtest: pipe-B-plane-2
[709.527764] Dynamic subtest pipe-B-plane-2: SUCCESS (0.175s)
[709.842312] Starting dynamic subtest: pipe-C-plane-0
[710.016177] Dynamic subtest pipe-C-plane-0: SUCCESS (0.213s)
[710.072641] Starting dynamic subtest: pipe-C-plane-1
[710.232480] Dynamic subtest pipe-C-plane-1: SUCCESS (0.209s)
[710.278493] Starting dynamic subtest: pipe-C-plane-2
[710.449176] Dynamic subtest pipe-C-plane-2: SUCCESS (0.209s)
[710.779178] Starting dynamic subtest: pipe-D-plane-0
[710.958582] Dynamic subtest pipe-D-plane-0: SUCCESS (0.213s)
[710.993096] Starting dynamic subtest: pipe-D-plane-1
[711.158894] Dynamic subtest pipe-D-plane-1: SUCCESS (0.193s)
[711.200080] Starting dynamic subtest: pipe-D-plane-2
[711.375425] Dynamic subtest pipe-D-plane-2: SUCCESS (0.209s)
[711.430051] Subtest plane-lut1d-lut1d: SUCCESS (3.630s)
[711.618277] [116/133] (327s left) gem_mmap_offset (partial-unmap)
[711.671544] Starting subtest: partial-unmap
[711.672982] Starting dynamic subtest: lmem0
[711.679614] Dynamic subtest lmem0: SUCCESS (0.009s)
[711.695943] Starting dynamic subtest: smem0
[711.697565] Dynamic subtest smem0: SUCCESS (0.006s)
[711.699220] Subtest partial-unmap: SUCCESS (0.019s)
[711.823300] [117/133] (327s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[713.323133] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[713.326185] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[713.555039] [118/133] (326s left) dmabuf_sync_file (import-multiple-read-only)
[713.614948] Starting subtest: import-multiple-read-only
[713.629238] Subtest import-multiple-read-only: SUCCESS (0.015s)
[713.747059] [119/133] (326s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[715.262958] Starting subtest: 4-tiled-32bpp-rotate-0
[715.265953] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[715.428000] [120/133] (324s left) gem_userptr_blits (process-exit-busy)
[715.491517] Starting subtest: process-exit-busy
[715.510372] Subtest process-exit-busy: SUCCESS (0.019s)
[715.730961] [121/133] (324s left) kms_cursor_crc (cursor-onscreen-64x21)
[717.376600] Starting subtest: cursor-onscreen-64x21
[717.384136] Starting dynamic subtest: pipe-A-HDMI-A-1
[720.135955] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.752s)
[720.174375] Starting dynamic subtest: pipe-D-HDMI-A-1
[722.816528] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.656s)
[722.818324] Subtest cursor-onscreen-64x21: SUCCESS (5.440s)
[723.265310] [122/133] (316s left) tools_test (sysfs_l3_parity)
[723.325146] Starting subtest: sysfs_l3_parity
[723.395198] Subtest sysfs_l3_parity: SKIP (0.078s)
[723.508874] [123/133] (316s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[723.560969] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[723.665570] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[723.787812] [124/133] (316s left) kms_fbcon_fbt (psr-suspend)
[723.839661] Starting subtest: psr-suspend
[723.842863] Subtest psr-suspend: SKIP (0.000s)
[724.053743] [125/133] (316s left) perf_pmu (multi-client)
[724.107653] Starting subtest: multi-client
[724.109307] Starting dynamic subtest: rcs0
[725.178189] Dynamic subtest rcs0: SUCCESS (1.066s)
[725.193560] Starting dynamic subtest: bcs0
[726.232861] Dynamic subtest bcs0: SUCCESS (1.049s)
[726.248289] Starting dynamic subtest: vcs0
[727.286162] Dynamic subtest vcs0: SUCCESS (1.048s)
[727.301567] Starting dynamic subtest: vcs1
[728.341224] Dynamic subtest vcs1: SUCCESS (1.049s)
[728.356611] Starting dynamic subtest: vecs0
[729.396674] Dynamic subtest vecs0: SUCCESS (1.050s)
[729.398441] Subtest multi-client: SUCCESS (5.289s)
[729.565252] [126/133] (310s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[731.066334] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[731.070213] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[731.252914] [127/133] (309s left) gem_ctx_isolation (preservation-s3)
[731.327622] Starting subtest: preservation-S3
[731.329027] Starting dynamic subtest: rcs0
[752.606433] Dynamic subtest rcs0: SUCCESS (10.706s)
[752.621443] Starting dynamic subtest: bcs0
[774.630675] Dynamic subtest bcs0: SUCCESS (10.461s)
[774.645876] Starting dynamic subtest: vcs0
[796.595454] Dynamic subtest vcs0: SUCCESS (10.494s)
[796.610964] Starting dynamic subtest: vcs1
[818.577689] Dynamic subtest vcs1: SUCCESS (10.466s)
[818.592845] Starting dynamic subtest: vecs0
[840.617776] Dynamic subtest vecs0: SUCCESS (10.534s)
[840.619485] Subtest preservation-S3: SUCCESS (52.669s)
[846.974733] [128/133] (199s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[848.474444] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[848.477366] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[848.667684] [129/133] (198s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[848.723428] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[848.724828] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[848.847419] [130/133] (198s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[848.904994] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[848.906408] Starting dynamic subtest: smem
[849.005695] Dynamic subtest smem: SUCCESS (0.102s)
[849.021025] Starting dynamic subtest: lmem0
[850.128954] Dynamic subtest lmem0: SUCCESS (1.118s)
[850.130576] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (1.224s)
[850.392990] [131/133] (196s left) gem_softpin (evict-prime)
[850.445595] Starting subtest: evict-prime
[850.447105] Starting dynamic subtest: rcs0
[851.651196] Dynamic subtest rcs0: SUCCESS (1.205s)
[851.667974] Starting dynamic subtest: bcs0
[852.848473] Dynamic subtest bcs0: SUCCESS (1.196s)
[852.863984] Starting dynamic subtest: vcs0
[854.065362] Dynamic subtest vcs0: SUCCESS (1.215s)
[854.081013] Starting dynamic subtest: vcs1
[855.265262] Dynamic subtest vcs1: SUCCESS (1.198s)
[855.281541] Starting dynamic subtest: vecs0
[856.412515] Dynamic subtest vecs0: SUCCESS (1.146s)
[856.428571] Starting dynamic subtest: all
[857.609339] Dynamic subtest all: SUCCESS (1.195s)
[857.611199] Subtest evict-prime: SUCCESS (7.164s)
[857.733065] [132/133] (189s left) kms_async_flips (invalid-async-flip-atomic)
[859.227318] Starting subtest: invalid-async-flip-atomic
[859.487562] Starting dynamic subtest: pipe-A-HDMI-A-1
[859.924065] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.437s)
[860.108463] Starting dynamic subtest: pipe-B-HDMI-A-1
[860.193411] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.099s)
[860.371017] Starting dynamic subtest: pipe-C-HDMI-A-1
[860.460111] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.103s)
[860.631136] Starting dynamic subtest: pipe-D-HDMI-A-1
[860.727538] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.110s)
[860.729017] Subtest invalid-async-flip-atomic: SUCCESS (1.503s)
[861.074871] [133/133] (186s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[862.578303] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[862.582040] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[862.779731] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_color
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_selftest
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: gem_pwrite
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: api_intel_allocator
results: parsing output: 14/ for test: gem_exec_whisper
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_pm_lpsp
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_hdr
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_getfb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: vgem_basic
results: parsing output: 44/ for test: kms_legacy_colorkey
results: parsing output: 45/ for test: kms_chamelium_hpd
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_vm_create
results: parsing output: 49/ for test: gem_partial_pwrite_pread
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_chamelium_frames
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_exec_endless
results: parsing output: 57/ for test: i915_query
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_atomic_transition
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: core_getclient
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: gem_tiling_max_stride
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: i915_module_load
results: parsing output: 72/ for test: vgem_basic
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: gem_readwrite
results: parsing output: 75/ for test: gem_lmem_swapping
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_ctx_engines
results: parsing output: 78/ for test: kms_dirtyfb
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: i915_pm_rps
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_draw_crc
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: prime_vgem
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_ctx_shared
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: gem_exec_flush
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: sriov_basic
results: parsing output: 107/ for test: kms_plane_cursor
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ccs
results: parsing output: 110/ for test: gem_ctx_sseu
results: parsing output: 111/ for test: kms_properties
results: parsing output: 112/ for test: gem_partial_pwrite_pread
results: parsing output: 113/ for test: kms_fbcon_fbt
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: gem_mmap_offset
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: dmabuf_sync_file
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: tools_test
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_fbcon_fbt
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_ctx_isolation
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: kms_async_flips
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.