[68.873719] Initializing watchdogs
[68.873800]   /dev/watchdog0
[68.904753] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[68.919636] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.924643] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.927899] [001/133] (960s left) kms_chamelium_color (ctm-limited-range)
[70.434157] Subtest ctm-limited-range: SKIP (0.000s)
[70.499166] [002/133] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[72.001640] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[72.004566] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[72.231403] [003/133] (957s left) kms_selftest (drm_damage_helper)
[72.285361] Starting subtest: drm_damage_helper
[72.359467] Starting dynamic subtest: drm_test_damage_iter_no_damage
[72.361127] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.060s)
[72.376237] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[72.438660] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.082s)
[72.476233] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[72.532570] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.094s)
[72.567918] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[72.604324] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.072s)
[72.624216] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[72.678127] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.072s)
[72.715776] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[72.747898] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.070s)
[72.768472] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[72.827857] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.076s)
[72.865632] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[72.902360] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.076s)
[72.923044] Starting dynamic subtest: drm_test_damage_iter_single_damage
[72.984054] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.077s)
[73.016473] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[73.054030] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.073s)
[73.076856] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[73.126387] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.068s)
[73.164650] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[73.209722] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.083s)
[73.245897] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[73.282947] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.075s)
[73.308888] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[73.356275] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.070s)
[73.390518] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[73.420104] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.065s)
[73.441772] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[73.510062] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.080s)
[73.545635] Starting dynamic subtest: drm_test_damage_iter_damage
[73.583083] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.082s)
[73.607592] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[73.662996] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.076s)
[73.699697] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[73.744194] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.079s)
[73.779961] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[73.820454] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.077s)
[73.850594] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[73.905598] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.081s)
[73.908301] Subtest drm_damage_helper: SUCCESS (1.620s)
[74.132780] [004/133] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[75.628179] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[75.630931] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[75.788907] [005/133] (953s left) gem_exec_reloc (basic-gtt-wc-active)
[75.859698] Subtest basic-gtt-wc-active: SKIP (0.000s)
[75.951399] [006/133] (953s left) gem_exec_balancer (nohangcheck)
[76.325527] Starting subtest: nohangcheck
[78.409891] Subtest nohangcheck: SUCCESS (2.082s)
[78.562627] [007/133] (951s left) gem_exec_fence (keep-in-fence)
[78.781537] Starting subtest: keep-in-fence
[78.783680] Starting dynamic subtest: rcs0
[78.861694] Dynamic subtest rcs0: SUCCESS (0.080s)
[78.871869] Starting dynamic subtest: bcs0
[78.913659] Dynamic subtest bcs0: SUCCESS (0.052s)
[78.929111] Starting dynamic subtest: vcs0
[78.974181] Dynamic subtest vcs0: SUCCESS (0.060s)
[79.005891] Starting dynamic subtest: vcs1
[79.050774] Dynamic subtest vcs1: SUCCESS (0.076s)
[79.065558] Starting dynamic subtest: vecs0
[79.108188] Dynamic subtest vecs0: SUCCESS (0.057s)
[79.110612] Subtest keep-in-fence: SUCCESS (0.327s)
[79.811378] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[79.814190] [008/133] (950s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[81.303649] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[81.306992] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[81.407258] [009/133] (948s left) gem_mmap_gtt (basic-small-copy-xy)
[81.462172] Subtest basic-small-copy-XY: SKIP (0.000s)
[81.533674] [010/133] (948s left) gem_pwrite (basic-random)
[81.582200] Subtest basic-random: SKIP (0.000s)
[81.671051] [011/133] (948s left) kms_psr (fbc-psr-primary-blt)
[83.164514] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[83.232829] [012/133] (947s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[84.725813] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[84.729442] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[84.848680] [013/133] (945s left) gem_render_copy (linear-to-vebox-y-tiled)
[84.916144] Starting subtest: linear-to-vebox-y-tiled
[84.918132] Starting dynamic subtest: smem
[85.006299] Dynamic subtest smem: SUCCESS (0.090s)
[85.016106] Starting dynamic subtest: lmem0
[85.763894] Dynamic subtest lmem0: SUCCESS (0.754s)
[85.765909] Subtest linear-to-vebox-y-tiled: SUCCESS (0.845s)
[86.020875] [014/133] (944s left) api_intel_allocator (fork-simple-stress-signal)
[86.066489] Starting subtest: fork-simple-stress-signal
[91.501512] Subtest fork-simple-stress-signal: SUCCESS (5.434s)
[91.708933] [015/133] (938s left) gem_exec_whisper (basic-sync)
[91.795330] Starting subtest: basic-sync
[95.014391] Subtest basic-sync: SUCCESS (3.218s)
[95.260289] [016/133] (935s left) kms_content_protection (lic-type-0-hdcp14)
[96.812199] Starting subtest: lic-type-0-hdcp14
[96.819205] Subtest lic-type-0-hdcp14: SKIP (0.002s)
[97.023920] [017/133] (933s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[98.517936] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[98.537280] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.018s)
[98.679645] [018/133] (932s left) gem_exec_schedule (wide)
[98.928448] Starting subtest: wide
[98.930459] Starting dynamic subtest: rcs0
[114.250660] Dynamic subtest rcs0: SUCCESS (15.320s)
[114.264195] Starting dynamic subtest: bcs0
[129.754272] Dynamic subtest bcs0: SUCCESS (15.500s)
[129.771069] Starting dynamic subtest: vcs0
[144.992040] Dynamic subtest vcs0: SUCCESS (15.237s)
[145.026570] Starting dynamic subtest: vcs1
[161.419944] Dynamic subtest vcs1: SUCCESS (16.431s)
[161.429929] Starting dynamic subtest: vecs0
[177.249985] Dynamic subtest vecs0: SUCCESS (15.830s)
[177.251642] Subtest wide: SUCCESS (78.322s)
[178.661088] [019/133] (852s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[178.710741] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[178.815614] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[178.943902] [020/133] (852s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[180.431254] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[180.432837] Starting dynamic subtest: pipe-A-HDMI-A-4
[180.439148] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[180.449164] Starting dynamic subtest: pipe-B-HDMI-A-4
[180.455609] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[180.465600] Starting dynamic subtest: pipe-C-HDMI-A-4
[180.471856] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[180.481505] Starting dynamic subtest: pipe-D-HDMI-A-4
[180.487795] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[180.491123] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[180.703638] [021/133] (850s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[182.203637] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[182.207046] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[182.433440] [022/133] (848s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[183.932977] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[184.008361] [023/133] (847s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[185.524279] Starting subtest: yf-tiled-8bpp-rotate-180
[185.527772] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[185.741217] [024/133] (845s left) syncobj_wait (invalid-reset-bad-pad)
[185.790285] Starting subtest: invalid-reset-bad-pad
[185.791928] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[185.903485] [025/133] (845s left) kms_pm_lpsp (kms-lpsp)
[188.399577] Starting subtest: kms-lpsp
[188.402407] Subtest kms-lpsp: SKIP (0.000s)
[188.541282] [026/133] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[190.046413] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[190.049337] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[190.229371] [027/133] (841s left) kms_pm_rpm (pc8-residency)
[193.976566] Starting subtest: pc8-residency
[193.979952] Subtest pc8-residency: SKIP (0.000s)
[194.903579] [028/133] (836s left) syncobj_timeline (single-wait-available-signaled)
[194.957977] Starting subtest: single-wait-available-signaled
[194.959609] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[195.077654] [029/133] (836s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[196.572962] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[196.575880] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[196.745685] [030/133] (835s left) kms_hdr (static-toggle)
[198.236338] Starting subtest: static-toggle
[198.240886] Subtest static-toggle: SKIP (0.000s)
[198.359662] [031/133] (833s left) kms_cursor_crc (cursor-sliding-128x128)
[200.029882] Starting subtest: cursor-sliding-128x128
[200.036355] Starting dynamic subtest: pipe-A-HDMI-A-4
[204.422303] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.386s)
[204.453948] Starting dynamic subtest: pipe-D-HDMI-A-4
[208.711265] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.267s)
[208.712750] Subtest cursor-sliding-128x128: SUCCESS (8.682s)
[209.104537] [032/133] (823s left) gem_exec_schedule (preempt-other-chain)
[209.171564] Starting subtest: preempt-other-chain
[209.173267] Starting dynamic subtest: rcs0
[209.335498] Dynamic subtest rcs0: SUCCESS (0.162s)
[209.345510] Starting dynamic subtest: bcs0
[209.479168] Dynamic subtest bcs0: SUCCESS (0.143s)
[209.489137] Starting dynamic subtest: vcs0
[209.619724] Dynamic subtest vcs0: SUCCESS (0.140s)
[209.629718] Starting dynamic subtest: vcs1
[209.761939] Dynamic subtest vcs1: SUCCESS (0.142s)
[209.771960] Starting dynamic subtest: vecs0
[209.903488] Dynamic subtest vecs0: SUCCESS (0.141s)
[209.905193] Subtest preempt-other-chain: SUCCESS (0.730s)
[210.344838] [033/133] (821s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[211.840222] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[214.939243] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.100s)
[215.129551] [034/133] (817s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[216.627465] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[216.630501] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[216.791450] [035/133] (815s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[218.303231] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[219.588726] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.285s)
[219.793016] [036/133] (812s left) kms_vblank (wait-busy-hang)
[221.282243] Starting subtest: wait-busy-hang
[221.283832] Starting dynamic subtest: pipe-A-HDMI-A-4
[247.460411] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.176s)
[247.473929] Starting dynamic subtest: pipe-D-HDMI-A-4
[272.464409] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.001s)
[272.465800] Subtest wait-busy-hang: SUCCESS (51.183s)
[272.645351] [037/133] (759s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[274.144557] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[274.146476] Starting dynamic subtest: pipe-A
[274.287306] Dynamic subtest pipe-A: SUCCESS (0.153s)
[274.297555] Starting dynamic subtest: pipe-B
[274.428172] Dynamic subtest pipe-B: SUCCESS (0.140s)
[274.438657] Starting dynamic subtest: pipe-C
[274.569360] Dynamic subtest pipe-C: SUCCESS (0.141s)
[274.579790] Starting dynamic subtest: pipe-D
[274.709903] Dynamic subtest pipe-D: SUCCESS (0.140s)
[274.711360] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.576s)
[274.881159] [038/133] (757s left) kms_psr (psr-cursor-render)
[276.375602] Subtest psr-cursor-render: SKIP (0.000s)
[276.446413] [039/133] (756s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[277.937129] Starting subtest: bad-pixel-format-y-tiled-ccs
[277.938556] Starting dynamic subtest: pipe-A-HDMI-A-4
[277.952554] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[277.962879] Starting dynamic subtest: pipe-B-HDMI-A-4
[277.977334] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[277.987170] Starting dynamic subtest: pipe-C-HDMI-A-4
[278.001945] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[278.012111] Starting dynamic subtest: pipe-D-HDMI-A-4
[278.027396] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[278.030530] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.006s)
[278.176798] [040/133] (754s left) perf (missing-sample-flags)
[278.315834] Starting subtest: missing-sample-flags
[278.317551] Subtest missing-sample-flags: SUCCESS (0.000s)
[278.395174] [041/133] (754s left) kms_flip (flip-vs-panning-vs-hang)
[279.887857] Starting subtest: flip-vs-panning-vs-hang
[279.892148] Starting dynamic subtest: A-HDMI-A4
[331.471808] Dynamic subtest A-HDMI-A4: SUCCESS (51.582s)
[331.482235] Starting dynamic subtest: D-HDMI-A4
[381.433726] Dynamic subtest D-HDMI-A4: SUCCESS (49.961s)
[381.435423] Subtest flip-vs-panning-vs-hang: SUCCESS (101.549s)
[381.621908] [042/133] (651s left) kms_getfb (getfb2-handle-protection)
[383.116468] Starting subtest: getfb2-handle-protection
[383.134879] Subtest getfb2-handle-protection: SUCCESS (0.020s)
[383.394298] [043/133] (649s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[384.892102] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[384.895466] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[385.145526] [044/133] (648s left) vgem_basic (bad-pad)
[385.209541] Starting subtest: bad-pad
[385.211104] Subtest bad-pad: SUCCESS (0.000s)
[385.327162] [045/133] (647s left) kms_legacy_colorkey (basic)
[386.815750] Starting subtest: basic
[386.817013] Starting dynamic subtest: pipe-A
[386.906462] Dynamic subtest pipe-A: SUCCESS (0.092s)
[386.922982] Starting dynamic subtest: pipe-B
[386.924671] Dynamic subtest pipe-B: SUCCESS (0.001s)
[386.946464] Starting dynamic subtest: pipe-C
[386.948403] Dynamic subtest pipe-C: SUCCESS (0.001s)
[386.984156] Starting dynamic subtest: pipe-D
[386.986220] Dynamic subtest pipe-D: SUCCESS (0.001s)
[386.988283] Subtest basic: SUCCESS (0.098s)
[387.099712] [046/133] (646s left) kms_chamelium_hpd (vga-hpd)
[388.633442] Subtest vga-hpd: SKIP (0.000s)
[388.742503] [047/133] (644s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[388.792174] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[388.903231] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[389.120710] [048/133] (644s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[390.610418] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[390.611955] Starting dynamic subtest: pipe-A-HDMI-A-4
[390.651593] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[390.662049] Starting dynamic subtest: pipe-B-HDMI-A-4
[390.703707] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[390.714110] Starting dynamic subtest: pipe-C-HDMI-A-4
[390.757196] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[390.767357] Starting dynamic subtest: pipe-D-HDMI-A-4
[390.817734] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[390.828145] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.017s)
[390.913533] [049/133] (642s left) gem_vm_create (isolation)
[390.987330] Starting subtest: isolation
[390.997848] Subtest isolation: SUCCESS (0.010s)
[391.200838] [050/133] (642s left) gem_partial_pwrite_pread (writes-after-reads-display)
[391.254162] Subtest writes-after-reads-display: SKIP (0.000s)
[391.336757] [051/133] (642s left) i915_drm_fdinfo (all-busy-check-all)
[391.387201] Starting subtest: all-busy-check-all
[391.405371] Subtest all-busy-check-all: SKIP (0.017s)
[391.506839] [052/133] (642s left) kms_flip (flip-vs-blocking-wf-vblank)
[393.045590] Starting subtest: flip-vs-blocking-wf-vblank
[393.051041] Starting dynamic subtest: A-HDMI-A4
[401.256736] Dynamic subtest A-HDMI-A4: SUCCESS (8.205s)
[401.268753] Starting dynamic subtest: B-HDMI-A4
[409.384172] Dynamic subtest B-HDMI-A4: SUCCESS (8.126s)
[409.395584] Starting dynamic subtest: C-HDMI-A4
[417.512917] Dynamic subtest C-HDMI-A4: SUCCESS (8.128s)
[417.523896] Starting dynamic subtest: D-HDMI-A4
[425.640135] Dynamic subtest D-HDMI-A4: SUCCESS (8.126s)
[425.641775] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.598s)
[425.845307] [053/133] (608s left) kms_chamelium_frames (dp-crc-fast)
[427.388425] Subtest dp-crc-fast: SKIP (0.000s)
[427.505613] [054/133] (606s left) kms_psr (pr-suspend)
[428.997792] Subtest pr-suspend: SKIP (0.000s)
[429.069585] [055/133] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[430.566523] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[430.569437] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[430.769621] [056/133] (603s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[432.283807] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[432.353563] [057/133] (601s left) gem_exec_endless (dispatch)
[432.430448] Starting subtest: dispatch
[432.432168] Starting dynamic subtest: rcs0
[432.439662] Dynamic subtest rcs0: SUCCESS (0.008s)
[432.450122] Starting dynamic subtest: bcs0
[432.453451] Dynamic subtest bcs0: SUCCESS (0.007s)
[432.463881] Starting dynamic subtest: vcs0
[432.467230] Dynamic subtest vcs0: SUCCESS (0.007s)
[432.479622] Starting dynamic subtest: vcs1
[432.483186] Dynamic subtest vcs1: SUCCESS (0.007s)
[432.493482] Starting dynamic subtest: vecs0
[432.497457] Dynamic subtest vecs0: SUCCESS (0.007s)
[432.499430] Subtest dispatch: SUCCESS (0.040s)
[432.657274] [058/133] (601s left) i915_query (query-topology-matches-eu-total)
[432.704443] Starting subtest: query-topology-matches-eu-total
[432.706112] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[432.815978] [059/133] (601s left) perf_pmu (busy-accuracy-2)
[432.879185] Starting subtest: busy-accuracy-2
[432.880938] Starting dynamic subtest: rcs0
[435.935056] Dynamic subtest rcs0: SUCCESS (3.054s)
[435.947048] Starting dynamic subtest: bcs0
[438.995138] Dynamic subtest bcs0: SUCCESS (3.060s)
[439.006705] Starting dynamic subtest: vcs0
[442.048330] Dynamic subtest vcs0: SUCCESS (3.052s)
[442.059936] Starting dynamic subtest: vcs1
[445.101374] Dynamic subtest vcs1: SUCCESS (3.052s)
[445.112981] Starting dynamic subtest: vecs0
[448.159346] Dynamic subtest vecs0: SUCCESS (3.057s)
[448.160767] Subtest busy-accuracy-2: SUCCESS (15.280s)
[448.363576] [060/133] (586s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[449.851895] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[449.853897] Starting dynamic subtest: pipe-A-valid-mode
[451.063806] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.210s)
[451.065244] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.212s)
[451.248270] [061/133] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[452.744649] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[452.747533] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[452.927060] [062/133] (581s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[454.419359] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[454.420737] Starting dynamic subtest: pipe-A-HDMI-A-4
[454.513372] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.094s)
[454.580333] Starting dynamic subtest: pipe-B-HDMI-A-4
[454.737794] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.168s)
[454.778292] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.359s)
[454.978320] [063/133] (579s left) kms_addfb_basic (bad-pitch-32)
[455.027329] Starting subtest: bad-pitch-32
[455.028855] Subtest bad-pitch-32: SUCCESS (0.000s)
[456.666456] [064/133] (578s left) kms_flip (basic-flip-vs-wf_vblank)
[458.156748] Starting subtest: basic-flip-vs-wf_vblank
[458.163229] Starting dynamic subtest: A-HDMI-A4
[459.371513] Dynamic subtest A-HDMI-A4: SUCCESS (1.208s)
[459.384450] Starting dynamic subtest: B-HDMI-A4
[460.500175] Dynamic subtest B-HDMI-A4: SUCCESS (1.127s)
[460.512544] Starting dynamic subtest: C-HDMI-A4
[461.461161] Dynamic subtest C-HDMI-A4: SUCCESS (0.959s)
[461.473277] Starting dynamic subtest: D-HDMI-A4
[462.589331] Dynamic subtest D-HDMI-A4: SUCCESS (1.127s)
[462.590632] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.435s)
[462.829332] [065/133] (572s left) core_getclient (basic)
[462.877955] Starting subtest: basic
[462.879488] Subtest basic: SUCCESS (0.000s)
[463.025671] [066/133] (572s left) gem_eio (wait-1us)
[463.213903] Starting subtest: wait-1us
[463.654804] Subtest wait-1us: SUCCESS (0.442s)
[465.225861] [067/133] (569s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[466.731082] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[466.733722] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.916967] [068/133] (568s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[468.408178] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[468.425782] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.017s)
[468.576213] [069/133] (566s left) gem_tiling_max_stride
[468.729637] [070/133] (566s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[470.218155] Starting subtest: cursorB-vs-flipA-legacy
[470.224259] Subtest cursorB-vs-flipA-legacy: SKIP (0.003s)
[470.335933] [071/133] (565s left) kms_plane (plane-position-hole-dpms)
[471.832743] Starting subtest: plane-position-hole-dpms
[472.268241] Starting dynamic subtest: pipe-A-plane-1
[472.733810] Dynamic subtest pipe-A-plane-1: SUCCESS (0.465s)
[472.746114] Starting dynamic subtest: pipe-A-plane-2
[473.200499] Dynamic subtest pipe-A-plane-2: SUCCESS (0.466s)
[473.212799] Starting dynamic subtest: pipe-A-plane-3
[473.669694] Dynamic subtest pipe-A-plane-3: SUCCESS (0.467s)
[473.682230] Starting dynamic subtest: pipe-A-plane-4
[474.116160] Dynamic subtest pipe-A-plane-4: SUCCESS (0.446s)
[474.128503] Starting dynamic subtest: pipe-A-plane-5
[474.565966] Dynamic subtest pipe-A-plane-5: SUCCESS (0.448s)
[474.578576] Starting dynamic subtest: pipe-A-plane-6
[475.012792] Dynamic subtest pipe-A-plane-6: SUCCESS (0.447s)
[475.025122] Starting dynamic subtest: pipe-A-plane-7
[475.035189] Dynamic subtest pipe-A-plane-7: SUCCESS (0.020s)
[475.325245] Starting dynamic subtest: pipe-B-plane-1
[475.735109] Dynamic subtest pipe-B-plane-1: SUCCESS (0.423s)
[475.747291] Starting dynamic subtest: pipe-B-plane-2
[476.159886] Dynamic subtest pipe-B-plane-2: SUCCESS (0.423s)
[476.172533] Starting dynamic subtest: pipe-B-plane-3
[476.612884] Dynamic subtest pipe-B-plane-3: SUCCESS (0.452s)
[476.624931] Starting dynamic subtest: pipe-B-plane-4
[477.066957] Dynamic subtest pipe-B-plane-4: SUCCESS (0.452s)
[477.079843] Starting dynamic subtest: pipe-B-plane-5
[477.520706] Dynamic subtest pipe-B-plane-5: SUCCESS (0.452s)
[477.533255] Starting dynamic subtest: pipe-B-plane-6
[477.956444] Dynamic subtest pipe-B-plane-6: SUCCESS (0.436s)
[477.968616] Starting dynamic subtest: pipe-B-plane-7
[477.987035] Dynamic subtest pipe-B-plane-7: SUCCESS (0.027s)
[477.988556] Subtest plane-position-hole-dpms: SUCCESS (6.154s)
[478.174869] [072/133] (557s left) i915_module_load (reload)
[478.224422] Starting subtest: reload
[482.505993] Subtest reload: SUCCESS (4.282s)
[482.584254] [073/133] (553s left) vgem_basic (sysfs)
[482.640979] Starting subtest: sysfs
[482.642737] Subtest sysfs: SUCCESS (0.001s)
[482.741290] [074/133] (552s left) i915_pm_rpm (gem-idle)
[487.021669] Starting subtest: gem-idle
[493.016683] Subtest gem-idle: SUCCESS (5.995s)
[493.875120] [075/133] (541s left) gem_readwrite (read-write)
[493.931195] Subtest read-write: SKIP (0.000s)
[494.055905] [076/133] (541s left) gem_lmem_swapping (verify-random)
[498.164371] Starting subtest: verify-random
[498.166224] Starting dynamic subtest: lmem0
[507.093757] Dynamic subtest lmem0: SUCCESS (8.926s)
[507.095450] Subtest verify-random: SUCCESS (8.927s)
[508.107999] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[508.109147] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[508.111929] [077/133] (527s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[512.836845] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[512.950343] [FACT kms_psr (fbc-psr2-cursor-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[512.955126] [FACT kms_psr (fbc-psr2-cursor-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[512.960807] [078/133] (523s left) gem_ctx_engines (invalid-engines)
[513.038467] Starting subtest: invalid-engines
[513.070406] Subtest invalid-engines: SUCCESS (0.032s)
[513.402123] [079/133] (522s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[514.895482] Starting subtest: fbc-dirtyfb-ioctl
[514.897591] Starting dynamic subtest: A-HDMI-A-4
[516.407029] Dynamic subtest A-HDMI-A-4: SUCCESS (1.511s)
[516.408505] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.514s)
[516.563352] [080/133] (519s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[516.613218] Starting subtest: invalid-single-wait-unsubmitted
[516.614788] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[516.734325] [081/133] (519s left) i915_pm_rps (waitboost)
[516.792860] Starting subtest: waitboost
[520.389099] Subtest waitboost: SUCCESS (3.598s)
[520.544367] [082/133] (515s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[522.063995] Starting subtest: 2x-long-flip-vs-cursor-atomic
[522.067356] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[522.280284] [083/133] (514s left) kms_draw_crc (draw-method-pwrite)
[523.772405] Starting subtest: draw-method-pwrite
[523.773863] Starting dynamic subtest: xrgb8888-untiled
[524.279260] Dynamic subtest xrgb8888-untiled: SUCCESS (0.507s)
[524.293951] Starting dynamic subtest: rgb565-untiled
[524.747540] Dynamic subtest rgb565-untiled: SUCCESS (0.465s)
[524.791482] Starting dynamic subtest: xrgb2101010-untiled
[525.229308] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.475s)
[525.241235] Starting dynamic subtest: xbgr16161616f-untiled
[525.697508] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.465s)
[525.744312] Starting dynamic subtest: xrgb8888-xtiled
[526.396399] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.692s)
[526.409100] Starting dynamic subtest: rgb565-xtiled
[527.079379] Dynamic subtest rgb565-xtiled: SUCCESS (0.681s)
[527.094182] Starting dynamic subtest: xrgb2101010-xtiled
[527.712712] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.631s)
[527.725277] Starting dynamic subtest: xbgr16161616f-xtiled
[528.464314] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.748s)
[528.476775] Starting dynamic subtest: xrgb8888-ytiled
[529.095828] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.632s)
[529.112046] Starting dynamic subtest: rgb565-ytiled
[529.545892] Dynamic subtest rgb565-ytiled: SUCCESS (0.448s)
[529.570218] Starting dynamic subtest: xrgb2101010-ytiled
[530.179108] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.631s)
[530.194155] Starting dynamic subtest: xbgr16161616f-ytiled
[531.195779] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (1.015s)
[531.197395] Subtest draw-method-pwrite: SUCCESS (7.425s)
[531.392570] [084/133] (505s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[532.904408] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[532.905872] Starting dynamic subtest: pipe-A-HDMI-A-4
[532.920110] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[532.931735] Starting dynamic subtest: pipe-B-HDMI-A-4
[532.946391] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[532.957587] Starting dynamic subtest: pipe-C-HDMI-A-4
[532.972547] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[532.983769] Starting dynamic subtest: pipe-D-HDMI-A-4
[532.999804] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[533.003038] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.013s)
[533.140978] [085/133] (503s left) gen9_exec_parse (batch-zero-length)
[533.196938] Subtest batch-zero-length: SKIP (0.000s)
[533.270575] [086/133] (503s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[534.767037] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[537.182123] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (2.417s)
[537.395121] [087/133] (499s left) syncobj_wait (invalid-signal-bad-pad)
[537.444919] Starting subtest: invalid-signal-bad-pad
[537.446484] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[537.596555] [088/133] (499s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[539.094427] Starting subtest: cursorB-vs-flipA-atomic
[539.097257] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[539.198511] [089/133] (497s left) prime_vgem (fence-read-hang)
[539.281449] Subtest fence-read-hang: SKIP (0.000s)
[539.520394] [090/133] (497s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[541.015955] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[541.018635] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[541.175948] [091/133] (496s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[541.229689] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[541.231102] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[541.347165] [092/133] (495s left) gem_userptr_blits (create-destroy-sync)
[541.410669] Starting subtest: create-destroy-sync
[546.445863] Subtest create-destroy-sync: SUCCESS (5.032s)
[546.622451] [093/133] (490s left) gem_exec_schedule (u-fairslice)
[546.682980] Starting subtest: u-fairslice
[546.684695] Starting dynamic subtest: rcs0
[548.725825] Dynamic subtest rcs0: SUCCESS (2.040s)
[548.737711] Starting dynamic subtest: bcs0
[550.746674] Dynamic subtest bcs0: SUCCESS (2.019s)
[550.758380] Starting dynamic subtest: vcs0
[552.767662] Dynamic subtest vcs0: SUCCESS (2.019s)
[552.779947] Starting dynamic subtest: vcs1
[554.789026] Dynamic subtest vcs1: SUCCESS (2.020s)
[554.801158] Starting dynamic subtest: vecs0
[556.810564] Dynamic subtest vecs0: SUCCESS (2.019s)
[556.812349] Subtest u-fairslice: SUCCESS (10.125s)
[557.219993] [094/133] (480s left) kms_cursor_crc (cursor-sliding-32x32)
[558.801208] Starting subtest: cursor-sliding-32x32
[558.853281] Subtest cursor-sliding-32x32: SKIP (0.047s)
[559.324515] [095/133] (478s left) gem_ctx_shared (detached-shared-gtt)
[559.388936] Starting subtest: detached-shared-gtt
[561.542669] Subtest detached-shared-gtt: SUCCESS (2.151s)
[562.482089] [096/133] (475s left) kms_big_fb (linear-8bpp-rotate-90)
[563.992743] Starting subtest: linear-8bpp-rotate-90
[564.093617] Subtest linear-8bpp-rotate-90: SKIP (0.100s)
[564.243766] [097/133] (473s left) kms_big_fb (x-tiled-addfb-size-overflow)
[565.754470] Starting subtest: x-tiled-addfb-size-overflow
[565.755909] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[565.939030] [098/133] (471s left) gem_userptr_blits (sync-unmap)
[566.002344] Starting subtest: sync-unmap
[566.024673] Subtest sync-unmap: SUCCESS (0.022s)
[566.255952] [099/133] (471s left) gem_exec_reloc (basic-cpu-read)
[566.310156] Subtest basic-cpu-read: SKIP (0.000s)
[566.406285] [100/133] (471s left) gem_exec_flush (basic-wb-set-default)
[566.462213] Subtest basic-wb-set-default: SKIP (0.000s)
[566.577958] [101/133] (471s left) kms_psr (psr-primary-mmap-gtt)
[568.068390] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[568.156807] [102/133] (470s left) kms_async_flips (async-flip-dpms)
[569.647802] Starting subtest: async-flip-dpms
[569.879063] Starting dynamic subtest: pipe-A-HDMI-A-4
[572.613505] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.734s)
[573.574876] Starting dynamic subtest: pipe-B-HDMI-A-4
[575.692550] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.135s)
[575.976373] Starting dynamic subtest: pipe-C-HDMI-A-4
[578.092877] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.139s)
[578.340152] Starting dynamic subtest: pipe-D-HDMI-A-4
[580.434826] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.133s)
[580.436400] Subtest async-flip-dpms: SUCCESS (10.788s)
[580.859935] [103/133] (457s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[582.371871] Starting subtest: y-tiled-64bpp-rotate-0
[584.812043] Subtest y-tiled-64bpp-rotate-0: SUCCESS (2.437s)
[585.016851] [104/133] (453s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[586.512087] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[586.590034] [105/133] (451s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[588.098943] Starting subtest: x-tiled-16bpp-rotate-90
[588.196039] Subtest x-tiled-16bpp-rotate-90: SKIP (0.094s)
[588.343360] [106/133] (450s left) gem_exec_params (larger-than-life-batch)
[588.396554] Starting subtest: larger-than-life-batch
[599.029569] Subtest larger-than-life-batch: SUCCESS (10.630s)
[599.650807] [107/133] (438s left) sriov_basic (enable-vfs-autoprobe-off)
[599.758525] Subtest enable-vfs-autoprobe-off: SKIP (0.000s)
[599.839593] [108/133] (438s left) kms_plane_cursor (overlay)
[601.335543] Starting subtest: overlay
[601.338444] Starting dynamic subtest: pipe-A-HDMI-A-4-size-64
[604.492515] Dynamic subtest pipe-A-HDMI-A-4-size-64: SUCCESS (3.155s)
[604.573779] Starting dynamic subtest: pipe-A-HDMI-A-4-size-128
[607.659988] Dynamic subtest pipe-A-HDMI-A-4-size-128: SUCCESS (3.099s)
[607.742836] Starting dynamic subtest: pipe-A-HDMI-A-4-size-256
[610.809454] Dynamic subtest pipe-A-HDMI-A-4-size-256: SUCCESS (3.082s)
[610.943584] Starting dynamic subtest: pipe-B-HDMI-A-4-size-64
[614.045642] Dynamic subtest pipe-B-HDMI-A-4-size-64: SUCCESS (3.120s)
[614.119674] Starting dynamic subtest: pipe-B-HDMI-A-4-size-128
[617.229280] Dynamic subtest pipe-B-HDMI-A-4-size-128: SUCCESS (3.132s)
[617.290557] Starting dynamic subtest: pipe-B-HDMI-A-4-size-256
[620.279116] Dynamic subtest pipe-B-HDMI-A-4-size-256: SUCCESS (2.999s)
[620.385385] Starting dynamic subtest: pipe-C-HDMI-A-4-size-64
[623.561219] Dynamic subtest pipe-C-HDMI-A-4-size-64: SUCCESS (3.189s)
[623.626137] Starting dynamic subtest: pipe-C-HDMI-A-4-size-128
[626.711087] Dynamic subtest pipe-C-HDMI-A-4-size-128: SUCCESS (3.099s)
[626.778540] Starting dynamic subtest: pipe-C-HDMI-A-4-size-256
[629.811446] Dynamic subtest pipe-C-HDMI-A-4-size-256: SUCCESS (3.049s)
[629.918067] Starting dynamic subtest: pipe-D-HDMI-A-4-size-64
[632.982194] Dynamic subtest pipe-D-HDMI-A-4-size-64: SUCCESS (3.077s)
[633.043257] Starting dynamic subtest: pipe-D-HDMI-A-4-size-128
[636.114548] Dynamic subtest pipe-D-HDMI-A-4-size-128: SUCCESS (3.083s)
[636.178490] Starting dynamic subtest: pipe-D-HDMI-A-4-size-256
[639.265237] Dynamic subtest pipe-D-HDMI-A-4-size-256: SUCCESS (3.099s)
[639.357578] Subtest overlay: SUCCESS (38.019s)
[639.538694] [109/133] (399s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[641.039092] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[641.042184] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[641.198904] [110/133] (397s left) gem_ccs (block-multicopy-inplace)
[641.263952] Starting subtest: block-multicopy-inplace
[641.267551] Subtest block-multicopy-inplace: SKIP (0.000s)
[641.392165] [111/133] (397s left) gem_ctx_sseu (invalid-args)
[641.468867] Subtest invalid-args: SKIP (0.000s)
[641.547191] [112/133] (397s left) kms_properties (plane-properties-legacy)
[643.036983] Starting subtest: plane-properties-legacy
[643.038675] Starting dynamic subtest: pipe-A-HDMI-A-4
[643.525649] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.481s)
[643.540521] Starting dynamic subtest: pipe-B-HDMI-A-4
[644.004413] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.437s)
[644.025997] Starting dynamic subtest: pipe-C-HDMI-A-4
[644.413631] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.450s)
[644.426899] Starting dynamic subtest: pipe-D-HDMI-A-4
[644.846298] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.431s)
[644.847723] Subtest plane-properties-legacy: SUCCESS (1.810s)
[645.023035] [113/133] (393s left) gem_partial_pwrite_pread (reads-snoop)
[645.077937] Subtest reads-snoop: SKIP (0.000s)
[645.189473] [114/133] (393s left) kms_fbcon_fbt (fbc-suspend)
[645.260608] Starting subtest: fbc-suspend
[701.686871] Subtest fbc-suspend: SUCCESS (34.014s)
[701.827760] [115/133] (337s left) kms_color_pipeline (plane-lut1d-lut1d)
[703.334271] Starting subtest: plane-lut1d-lut1d
[703.535678] Starting dynamic subtest: pipe-A-plane-0
[703.783785] Dynamic subtest pipe-A-plane-0: SUCCESS (0.248s)
[703.816020] Starting dynamic subtest: pipe-A-plane-1
[703.983787] Dynamic subtest pipe-A-plane-1: SUCCESS (0.193s)
[704.015969] Starting dynamic subtest: pipe-A-plane-2
[704.184181] Dynamic subtest pipe-A-plane-2: SUCCESS (0.193s)
[704.487515] Starting dynamic subtest: pipe-B-plane-0
[704.645710] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s)
[704.684597] Starting dynamic subtest: pipe-B-plane-1
[704.859542] Dynamic subtest pipe-B-plane-1: SUCCESS (0.209s)
[704.895236] Starting dynamic subtest: pipe-B-plane-2
[705.048483] Dynamic subtest pipe-B-plane-2: SUCCESS (0.176s)
[705.341116] Starting dynamic subtest: pipe-C-plane-0
[705.516043] Dynamic subtest pipe-C-plane-0: SUCCESS (0.213s)
[705.562462] Starting dynamic subtest: pipe-C-plane-1
[705.733011] Dynamic subtest pipe-C-plane-1: SUCCESS (0.209s)
[705.777668] Starting dynamic subtest: pipe-C-plane-2
[705.949540] Dynamic subtest pipe-C-plane-2: SUCCESS (0.209s)
[706.237805] Starting dynamic subtest: pipe-D-plane-0
[706.405164] Dynamic subtest pipe-D-plane-0: SUCCESS (0.198s)
[706.440412] Starting dynamic subtest: pipe-D-plane-1
[706.605200] Dynamic subtest pipe-D-plane-1: SUCCESS (0.192s)
[706.644035] Starting dynamic subtest: pipe-D-plane-2
[706.821488] Dynamic subtest pipe-D-plane-2: SUCCESS (0.209s)
[706.875884] Subtest plane-lut1d-lut1d: SUCCESS (3.541s)
[707.092602] [116/133] (332s left) gem_mmap_offset (partial-unmap)
[707.142048] Starting subtest: partial-unmap
[707.143609] Starting dynamic subtest: lmem0
[707.150841] Dynamic subtest lmem0: SUCCESS (0.009s)
[707.166353] Starting dynamic subtest: smem0
[707.168108] Dynamic subtest smem0: SUCCESS (0.006s)
[707.169724] Subtest partial-unmap: SUCCESS (0.018s)
[707.310088] [117/133] (332s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[708.810074] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[708.813081] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[708.986204] [118/133] (330s left) dmabuf_sync_file (import-multiple-read-only)
[709.044744] Starting subtest: import-multiple-read-only
[709.154053] Subtest import-multiple-read-only: SUCCESS (0.113s)
[709.303542] [119/133] (330s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[710.818863] Starting subtest: 4-tiled-32bpp-rotate-0
[710.821978] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[711.073840] [120/133] (328s left) gem_userptr_blits (process-exit-busy)
[711.154523] Starting subtest: process-exit-busy
[711.174383] Subtest process-exit-busy: SUCCESS (0.020s)
[711.384308] [121/133] (328s left) kms_cursor_crc (cursor-onscreen-64x21)
[713.027546] Starting subtest: cursor-onscreen-64x21
[713.034968] Starting dynamic subtest: pipe-A-HDMI-A-4
[715.761957] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.727s)
[715.799807] Starting dynamic subtest: pipe-D-HDMI-A-4
[718.304715] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.519s)
[718.306397] Subtest cursor-onscreen-64x21: SUCCESS (5.277s)
[718.754731] [122/133] (321s left) tools_test (sysfs_l3_parity)
[718.812847] Starting subtest: sysfs_l3_parity
[718.886148] Subtest sysfs_l3_parity: SKIP (0.081s)
[719.002654] [123/133] (321s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[719.052216] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[719.159362] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[719.364590] [124/133] (320s left) kms_fbcon_fbt (psr-suspend)
[719.417026] Starting subtest: psr-suspend
[719.420619] Subtest psr-suspend: SKIP (0.000s)
[719.608396] [125/133] (320s left) perf_pmu (multi-client)
[719.661176] Starting subtest: multi-client
[719.662868] Starting dynamic subtest: rcs0
[720.728919] Dynamic subtest rcs0: SUCCESS (1.063s)
[720.744328] Starting dynamic subtest: bcs0
[721.784474] Dynamic subtest bcs0: SUCCESS (1.050s)
[721.799852] Starting dynamic subtest: vcs0
[722.838246] Dynamic subtest vcs0: SUCCESS (1.049s)
[722.853862] Starting dynamic subtest: vcs1
[723.891505] Dynamic subtest vcs1: SUCCESS (1.048s)
[723.907145] Starting dynamic subtest: vecs0
[724.945779] Dynamic subtest vecs0: SUCCESS (1.049s)
[724.947629] Subtest multi-client: SUCCESS (5.284s)
[725.120669] [126/133] (315s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[726.618218] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[726.622019] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[726.796912] [127/133] (313s left) gem_ctx_isolation (preservation-s3)
[726.858395] Starting subtest: preservation-S3
[726.860220] Starting dynamic subtest: rcs0
[748.122459] Dynamic subtest rcs0: SUCCESS (10.765s)
[748.137246] Starting dynamic subtest: bcs0
[770.134946] Dynamic subtest bcs0: SUCCESS (10.508s)
[770.149761] Starting dynamic subtest: vcs0
[792.102811] Dynamic subtest vcs0: SUCCESS (10.489s)
[792.118267] Starting dynamic subtest: vcs1
[814.133559] Dynamic subtest vcs1: SUCCESS (10.549s)
[814.148880] Starting dynamic subtest: vecs0
[836.096763] Dynamic subtest vecs0: SUCCESS (10.504s)
[836.100055] Subtest preservation-S3: SUCCESS (52.824s)
[841.387686] [128/133] (204s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[842.915332] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[842.918076] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[843.097599] [129/133] (202s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[843.148696] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[843.150376] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[843.269030] [130/133] (202s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[843.324155] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[843.325687] Starting dynamic subtest: smem
[843.426044] Dynamic subtest smem: SUCCESS (0.101s)
[843.441124] Starting dynamic subtest: lmem0
[844.541669] Dynamic subtest lmem0: SUCCESS (1.111s)
[844.543298] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (1.215s)
[844.804185] [131/133] (200s left) gem_softpin (evict-prime)
[844.858788] Starting subtest: evict-prime
[844.860412] Starting dynamic subtest: rcs0
[846.085337] Dynamic subtest rcs0: SUCCESS (1.226s)
[846.101142] Starting dynamic subtest: bcs0
[847.249340] Dynamic subtest bcs0: SUCCESS (1.163s)
[847.265024] Starting dynamic subtest: vcs0
[848.469591] Dynamic subtest vcs0: SUCCESS (1.216s)
[848.485518] Starting dynamic subtest: vcs1
[849.669379] Dynamic subtest vcs1: SUCCESS (1.201s)
[849.684704] Starting dynamic subtest: vecs0
[850.832414] Dynamic subtest vecs0: SUCCESS (1.162s)
[850.850765] Starting dynamic subtest: all
[852.029593] Dynamic subtest all: SUCCESS (1.196s)
[852.031376] Subtest evict-prime: SUCCESS (7.172s)
[852.191221] [132/133] (193s left) kms_async_flips (invalid-async-flip-atomic)
[853.685379] Starting subtest: invalid-async-flip-atomic
[853.915225] Starting dynamic subtest: pipe-A-HDMI-A-4
[854.352922] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.438s)
[854.515517] Starting dynamic subtest: pipe-B-HDMI-A-4
[854.598863] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.097s)
[854.777346] Starting dynamic subtest: pipe-C-HDMI-A-4
[854.864105] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.100s)
[855.036385] Starting dynamic subtest: pipe-D-HDMI-A-4
[855.129908] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.107s)
[855.131655] Subtest invalid-async-flip-atomic: SUCCESS (1.445s)
[855.473336] [133/133] (190s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[856.974497] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[856.978382] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[857.143128] 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.