[59.885197] Initializing watchdogs
[59.885245]   /dev/watchdog0
[59.900392] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.904821] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.907302] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.910717] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[60.039259] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[60.043123] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.159415] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[60.215863] Starting subtest: basic-S3-devices
[60.218144] Starting dynamic subtest: smem
[71.897065] Dynamic subtest smem: SUCCESS (11.688s)
[71.899799] Subtest basic-S3-devices: SUCCESS (11.689s)
[72.098707] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[72.176612] Starting subtest: y-tiled-ccs-to-yf-tiled
[72.180845] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[72.384570] [004/133] (948s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[72.481199] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[72.483592] Starting dynamic subtest: pipe-A-eDP-1
[72.507597] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[72.518779] Starting dynamic subtest: pipe-B-eDP-1
[72.539771] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[72.547772] Starting dynamic subtest: pipe-C-eDP-1
[72.568505] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[72.576818] Starting dynamic subtest: pipe-D-eDP-1
[72.597776] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[72.602123] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[74.806989] [005/133] (945s left) kms_flip (bo-too-big)
[74.896391] Starting subtest: bo-too-big
[74.898622] Starting dynamic subtest: A-eDP1
[76.250718] Dynamic subtest A-eDP1: SUCCESS (1.356s)
[76.261108] Starting dynamic subtest: B-eDP1
[77.567444] Dynamic subtest B-eDP1: SUCCESS (1.316s)
[77.576116] Starting dynamic subtest: C-eDP1
[78.904775] Dynamic subtest C-eDP1: SUCCESS (1.337s)
[78.915973] Starting dynamic subtest: D-eDP1
[80.243633] Dynamic subtest D-eDP1: SUCCESS (1.338s)
[80.246095] Subtest bo-too-big: SUCCESS (5.353s)
[81.464999] [006/133] (939s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[81.535572] Starting subtest: multi-wait-available-unsubmitted-signaled
[81.537959] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[81.662176] [007/133] (938s left) kms_lease (lease-uevent)
[81.760837] Starting subtest: lease-uevent
[82.780617] Subtest lease-uevent: SUCCESS (1.021s)
[82.907819] [008/133] (937s left) gem_exec_fence (syncobj-timeline-wait)
[83.500160] Starting subtest: syncobj-timeline-wait
[84.903899] Subtest syncobj-timeline-wait: SUCCESS (1.404s)
[87.064709] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[87.067975] [009/133] (933s left) kms_chamelium_color (gamma)
[87.188408] Subtest gamma: SKIP (0.000s)
[87.235456] [010/133] (933s left) prime_mmap (test_errors)
[87.295618] Starting subtest: test_errors
[87.298063] Starting dynamic subtest: test_errors-smem
[87.389288] Dynamic subtest test_errors-smem: SUCCESS (0.096s)
[87.391866] Subtest test_errors: SUCCESS (0.096s)
[87.505992] [011/133] (933s left) i915_drm_fdinfo (idle)
[87.546908] Starting subtest: idle
[87.549393] Starting dynamic subtest: rcs0
[88.140029] Dynamic subtest rcs0: SUCCESS (0.594s)
[88.149405] Starting dynamic subtest: bcs0
[88.647113] Dynamic subtest bcs0: SUCCESS (0.504s)
[88.657839] Starting dynamic subtest: vcs0
[89.151551] Dynamic subtest vcs0: SUCCESS (0.504s)
[89.162751] Starting dynamic subtest: vcs1
[89.656416] Dynamic subtest vcs1: SUCCESS (0.504s)
[89.667765] Starting dynamic subtest: vecs0
[90.161372] Dynamic subtest vecs0: SUCCESS (0.504s)
[90.172805] Starting dynamic subtest: ccs0
[90.666214] Dynamic subtest ccs0: SUCCESS (0.504s)
[90.668917] Subtest idle: SUCCESS (3.120s)
[90.766262] [012/133] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[90.876284] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[90.880272] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[91.017906] [013/133] (929s left) kms_invalid_mode (zero-hdisplay)
[91.122964] Starting subtest: zero-hdisplay
[91.125120] Starting dynamic subtest: pipe-A-eDP-1
[91.409572] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[91.418775] Starting dynamic subtest: pipe-B-eDP-1
[91.420626] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[91.428116] Starting dynamic subtest: pipe-C-eDP-1
[91.430771] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[91.440979] Starting dynamic subtest: pipe-D-eDP-1
[91.443474] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[91.445608] Subtest zero-hdisplay: SUCCESS (0.292s)
[92.291822] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[92.385110] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[92.387468] Starting dynamic subtest: pipe-A
[92.448231] Dynamic subtest pipe-A: SUCCESS (0.065s)
[92.461606] Starting dynamic subtest: pipe-B
[93.588607] Dynamic subtest pipe-B: SUCCESS (1.139s)
[93.599074] Starting dynamic subtest: pipe-C
[94.699564] Dynamic subtest pipe-C: SUCCESS (1.110s)
[94.713162] Starting dynamic subtest: pipe-D
[95.843568] Dynamic subtest pipe-D: SUCCESS (1.144s)
[95.846058] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.461s)
[97.016811] [015/133] (923s left) drm_read (fault-buffer)
[97.163774] Starting subtest: fault-buffer
[97.166174] Subtest fault-buffer: SUCCESS (0.000s)
[97.329114] [016/133] (923s left) gem_ccs (suspend-resume)
[97.378619] Starting subtest: suspend-resume
[97.382603] Subtest suspend-resume: SKIP (0.000s)
[97.506173] [017/133] (923s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[97.593964] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[97.596281] Starting dynamic subtest: pipe-A-eDP-1
[97.618296] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[97.628801] Starting dynamic subtest: pipe-B-eDP-1
[97.649210] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.657097] Starting dynamic subtest: pipe-C-eDP-1
[97.677827] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.686196] Starting dynamic subtest: pipe-D-eDP-1
[97.708183] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[97.712522] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[99.795418] [018/133] (921s left) gem_close (many-handles-one-vma)
[99.857266] Starting subtest: many-handles-one-vma
[99.881238] Subtest many-handles-one-vma: SUCCESS (0.025s)
[100.030728] [019/133] (921s left) gem_busy (extended)
[100.215592] Starting subtest: extended
[100.218069] Starting dynamic subtest: rcs0
[100.313435] Dynamic subtest rcs0: SUCCESS (0.097s)
[100.323950] Starting dynamic subtest: bcs0
[100.357842] Dynamic subtest bcs0: SUCCESS (0.043s)
[100.371811] Starting dynamic subtest: vcs0
[101.912507] Dynamic subtest vcs0: SUCCESS (1.551s)
[101.924090] Starting dynamic subtest: vcs1
[103.898456] Dynamic subtest vcs1: SUCCESS (1.985s)
[103.909862] Starting dynamic subtest: vecs0
[105.881271] Dynamic subtest vecs0: SUCCESS (1.981s)
[105.896254] Starting dynamic subtest: ccs0
[105.927613] Dynamic subtest ccs0: SUCCESS (0.047s)
[105.930688] Subtest extended: SUCCESS (5.711s)
[106.186220] [020/133] (914s left) kms_vblank (ts-continuation-suspend)
[106.289827] Starting subtest: ts-continuation-suspend
[106.291845] Starting dynamic subtest: pipe-A-eDP-1
[122.492907] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.565s)
[122.506274] Starting dynamic subtest: pipe-D-eDP-1
[139.478021] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.203s)
[139.480782] Subtest ts-continuation-suspend: SUCCESS (3.770s)
[140.315873] [021/133] (880s left) perf_pmu (semaphore-wait-idle)
[140.367779] Starting subtest: semaphore-wait-idle
[140.370258] Starting dynamic subtest: rcs0
[140.882176] Dynamic subtest rcs0: SUCCESS (0.518s)
[140.894157] Starting dynamic subtest: bcs0
[141.395442] Dynamic subtest bcs0: SUCCESS (0.515s)
[141.407791] Starting dynamic subtest: vcs0
[141.907563] Dynamic subtest vcs0: SUCCESS (0.515s)
[141.919991] Starting dynamic subtest: vcs1
[142.419240] Dynamic subtest vcs1: SUCCESS (0.514s)
[142.430839] Starting dynamic subtest: vecs0
[142.932153] Dynamic subtest vecs0: SUCCESS (0.514s)
[142.944306] Starting dynamic subtest: ccs0
[143.445431] Dynamic subtest ccs0: SUCCESS (0.516s)
[143.448485] Subtest semaphore-wait-idle: SUCCESS (3.100s)
[143.603317] [022/133] (877s left) kms_debugfs (display-off-read-all)
[143.705697] Starting subtest: display-off-read-all
[143.993409] Subtest display-off-read-all: SUCCESS (0.291s)
[144.802606] [023/133] (876s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[144.908904] Starting subtest: fbc-rgb101010-draw-blt
[149.499612] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.612s)
[150.713373] [024/133] (870s left) gem_ctx_param (invalid-get-no-zeromap)
[150.765875] Starting subtest: invalid-get-no-zeromap
[150.768718] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[150.882819] [025/133] (870s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[150.978860] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[150.983817] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[151.112989] [026/133] (870s left) gem_exec_big (single)
[151.178738] Starting subtest: single
[153.488250] Subtest single: SUCCESS (2.314s)
[153.720854] [027/133] (867s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[153.893259] Starting subtest: psr-rgb101010-draw-mmap-gtt
[153.898580] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[154.029600] [028/133] (867s left) gem_exec_flush (basic-uc-prw-default)
[154.094725] Starting subtest: basic-uc-prw-default
[159.563384] Subtest basic-uc-prw-default: SUCCESS (5.478s)
[159.779182] [029/133] (861s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[159.883801] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[159.888816] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[160.014150] [030/133] (861s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[160.122033] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[167.071869] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.958s)
[167.240437] [031/133] (854s left) gem_exec_create (forked)
[167.320982] Starting subtest: forked
[167.323696] Starting dynamic subtest: smem
[189.331044] Dynamic subtest smem: SUCCESS (22.001s)
[189.334203] Subtest forked: SUCCESS (22.003s)
[189.550336] [032/133] (832s left) kms_feature_discovery (display-1x)
[189.657981] Starting subtest: display-1x
[189.660766] Subtest display-1x: SUCCESS (0.000s)
[189.754290] [033/133] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[189.849786] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[189.854943] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[189.980188] [034/133] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[190.087811] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[190.092921] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[190.221823] [035/133] (831s left) gem_render_copy_redux (interruptible)
[190.282801] Starting subtest: interruptible
[190.589229] Subtest interruptible: SUCCESS (0.309s)
[190.748123] [036/133] (831s left) i915_pm_rpm (system-suspend-execbuf)
[192.500354] Starting subtest: system-suspend-execbuf
[251.152298] Subtest system-suspend-execbuf: SUCCESS (43.118s)
[251.544134] [037/133] (770s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[251.650723] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[251.654697] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[251.788671] [038/133] (770s left) gem_request_retire (retire-vma-not-inactive)
[251.852054] Starting subtest: retire-vma-not-inactive
[251.911219] Subtest retire-vma-not-inactive: SUCCESS (0.056s)
[252.068673] [039/133] (769s left) i915_pm_rps (thresholds-idle)
[252.135849] Starting subtest: thresholds-idle
[252.140268] Subtest thresholds-idle: SKIP (0.001s)
[252.289829] [040/133] (769s left) gem_ctx_persistence (legacy-engines-queued)
[252.354585] Starting subtest: legacy-engines-queued
[252.356947] Starting dynamic subtest: render
[252.432672] Dynamic subtest render: SUCCESS (0.077s)
[252.445216] Starting dynamic subtest: bsd1
[253.929612] Dynamic subtest bsd1: SUCCESS (1.493s)
[253.942262] Starting dynamic subtest: bsd2
[255.911563] Dynamic subtest bsd2: SUCCESS (1.978s)
[255.924138] Starting dynamic subtest: blt
[255.990061] Dynamic subtest blt: SUCCESS (0.078s)
[256.001639] Starting dynamic subtest: vebox
[257.895673] Dynamic subtest vebox: SUCCESS (1.902s)
[257.898504] Subtest legacy-engines-queued: SUCCESS (5.540s)
[257.999741] [041/133] (764s left) i915_hangman (gt-error-state-capture)
[258.077737] Starting subtest: gt-error-state-capture
[258.079682] Starting dynamic subtest: rcs0
[269.928049] Dynamic subtest rcs0: SUCCESS (11.851s)
[269.940797] Starting dynamic subtest: bcs0
[281.895540] Dynamic subtest bcs0: SUCCESS (11.969s)
[281.908198] Starting dynamic subtest: vcs0
[293.863615] Dynamic subtest vcs0: SUCCESS (11.970s)
[293.879269] Starting dynamic subtest: vcs1
[304.871191] Dynamic subtest vcs1: SUCCESS (11.009s)
[304.884149] Starting dynamic subtest: vecs0
[314.919962] Dynamic subtest vecs0: SUCCESS (10.043s)
[314.931487] Starting dynamic subtest: ccs0
[326.887514] Dynamic subtest ccs0: SUCCESS (11.963s)
[326.890359] Subtest gt-error-state-capture: SUCCESS (68.815s)
[326.993467] [042/133] (695s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[327.243908] Starting subtest: cursor-rapid-movement-128x42
[327.292774] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[327.536416] [043/133] (694s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[327.600795] Subtest writes-after-reads-uncached: SKIP (0.000s)
[327.687948] [044/133] (694s left) gem_mmap_wc (coherency)
[327.751595] Subtest coherency: SKIP (0.000s)
[327.819030] [045/133] (694s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[327.881060] Starting subtest: single-wait-all-for-submit-signaled
[327.883516] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[327.984879] [046/133] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[328.089431] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[331.813170] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.727s)
[333.021026] [047/133] (689s left) kms_psr (fbc-psr-primary-mmap-cpu)
[333.123973] Starting subtest: fbc-psr-primary-mmap-cpu
[333.126342] Starting dynamic subtest: eDP-1
[333.130599] Dynamic subtest eDP-1: SKIP (0.000s)
[333.134963] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[333.223965] [048/133] (689s left) kms_invalid_mode (bad-vsync-start)
[333.319453] Starting subtest: bad-vsync-start
[333.321826] Starting dynamic subtest: pipe-A-eDP-1
[333.607780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[333.618097] Starting dynamic subtest: pipe-B-eDP-1
[333.620511] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[333.629833] Starting dynamic subtest: pipe-C-eDP-1
[333.631699] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[333.640443] Starting dynamic subtest: pipe-D-eDP-1
[333.642346] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[333.644269] Subtest bad-vsync-start: SUCCESS (0.294s)
[334.443592] [049/133] (687s left) gem_exec_reloc (basic-wc-gtt)
[334.512135] Subtest basic-wc-gtt: SKIP (0.000s)
[334.594084] [050/133] (687s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[334.651536] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[334.722893] [051/133] (687s left) kms_prop_blob (blob-multiple)
[334.777464] Starting subtest: blob-multiple
[334.779711] Subtest blob-multiple: SUCCESS (0.002s)
[334.921656] [052/133] (687s left) api_intel_allocator (open-vm)
[334.981863] Starting subtest: open-vm
[334.983762] Subtest open-vm: SUCCESS (0.004s)
[335.136559] [053/133] (687s left) kms_getfb (getfb-repeated-different-handles)
[335.237912] Starting subtest: getfb-repeated-different-handles
[335.240022] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[335.377052] [054/133] (687s left) kms_content_protection (legacy-hdcp14)
[335.527967] Starting subtest: legacy-hdcp14
[335.531925] Subtest legacy-hdcp14: SKIP (0.000s)
[335.696548] [055/133] (687s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[336.107647] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[336.946006] [056/133] (685s left) kms_flip (blocking-absolute-wf_vblank)
[337.043635] Starting subtest: blocking-absolute-wf_vblank
[337.046050] Starting dynamic subtest: A-eDP1
[345.805195] Dynamic subtest A-eDP1: SUCCESS (8.761s)
[345.817494] Starting dynamic subtest: B-eDP1
[354.537432] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[354.549373] Starting dynamic subtest: C-eDP1
[363.259542] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[363.271106] Starting dynamic subtest: D-eDP1
[371.975807] Dynamic subtest D-eDP1: SUCCESS (8.716s)
[371.978080] Subtest blocking-absolute-wf_vblank: SUCCESS (34.939s)
[373.208119] [057/133] (649s left) gem_mmap_offset (bad-object)
[373.273299] Starting subtest: bad-object
[373.275292] Subtest bad-object: SUCCESS (0.001s)
[373.405867] [058/133] (649s left) kms_psr (psr2-no-drrs)
[373.504404] Starting subtest: psr2-no-drrs
[373.506732] Starting dynamic subtest: eDP-1
[375.150207] Dynamic subtest eDP-1: SUCCESS (1.647s)
[375.152537] Subtest psr2-no-drrs: SUCCESS (1.648s)
[375.973433] [059/133] (646s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[376.040564] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[376.129323] [060/133] (646s left) kms_vblank (wait-idle)
[376.218572] Starting subtest: wait-idle
[376.220819] Starting dynamic subtest: pipe-A-eDP-1
[377.989964] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.769s)
[378.003918] Starting dynamic subtest: pipe-D-eDP-1
[380.385148] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.394s)
[380.387368] Subtest wait-idle: SUCCESS (4.167s)
[381.232632] [061/133] (641s left) gem_exec_whisper (basic-contexts-all)
[381.310585] Starting subtest: basic-contexts-all
[392.316505] Subtest basic-contexts-all: SUCCESS (11.009s)
[392.527650] [062/133] (630s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[392.635579] Starting subtest: x-tiled-16bpp-rotate-0
[393.992589] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.358s)
[394.138029] [063/133] (628s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[394.231406] Starting subtest: plane-primary-overlay-mutable-zpos
[397.628302] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.397s)
[398.839771] [064/133] (624s left) gen9_exec_parse (bb-start-cmd)
[398.904438] Subtest bb-start-cmd: SKIP (0.000s)
[398.970924] [065/133] (624s left) kms_cursor_crc (cursor-alpha-opaque)
[399.058302] Starting subtest: cursor-alpha-opaque
[399.060189] Starting dynamic subtest: pipe-A-eDP-1
[399.678705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[399.688929] Starting dynamic subtest: pipe-D-eDP-1
[401.011866] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[401.014538] Subtest cursor-alpha-opaque: SUCCESS (1.955s)
[401.921005] [066/133] (621s left) kms_cursor_crc (cursor-sliding-64x64)
[402.089035] Starting subtest: cursor-sliding-64x64
[402.093728] Starting dynamic subtest: pipe-A-eDP-1
[405.342377] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.248s)
[405.372167] Starting dynamic subtest: pipe-D-eDP-1
[409.282155] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.917s)
[409.284173] Subtest cursor-sliding-64x64: SUCCESS (7.192s)
[410.169489] [067/133] (613s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[410.274698] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[417.063652] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.793s)
[417.246289] [068/133] (606s left) gem_ctx_shared (exec-single-timeline)
[417.305260] Starting subtest: exec-single-timeline
[417.307587] Starting dynamic subtest: rcs0
[418.341092] Dynamic subtest rcs0: SUCCESS (1.034s)
[418.352345] Starting dynamic subtest: bcs0
[419.429300] Dynamic subtest bcs0: SUCCESS (1.086s)
[419.442056] Starting dynamic subtest: vcs0
[420.518452] Dynamic subtest vcs0: SUCCESS (1.086s)
[420.532138] Starting dynamic subtest: vcs1
[421.606545] Dynamic subtest vcs1: SUCCESS (1.085s)
[421.619197] Starting dynamic subtest: vecs0
[422.694533] Dynamic subtest vecs0: SUCCESS (1.085s)
[422.707859] Starting dynamic subtest: ccs0
[423.782194] Dynamic subtest ccs0: SUCCESS (1.085s)
[423.785390] Subtest exec-single-timeline: SUCCESS (6.480s)
[424.000388] [069/133] (599s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[424.090151] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[424.092748] Starting dynamic subtest: pipe-A
[425.262493] Dynamic subtest pipe-A: SUCCESS (1.175s)
[425.272022] Starting dynamic subtest: pipe-B
[427.559998] Dynamic subtest pipe-B: SUCCESS (2.297s)
[427.569817] Starting dynamic subtest: pipe-C
[428.766873] Dynamic subtest pipe-C: SUCCESS (1.206s)
[428.777366] Starting dynamic subtest: pipe-D
[429.907576] Dynamic subtest pipe-D: SUCCESS (1.140s)
[429.909928] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.821s)
[431.127205] [070/133] (592s left) gem_wait (write-busy)
[431.213142] Starting subtest: write-busy
[431.215493] Starting dynamic subtest: all-engines
[431.843253] Dynamic subtest all-engines: SUCCESS (0.629s)
[431.860370] Starting dynamic subtest: rcs0
[432.398878] Dynamic subtest rcs0: SUCCESS (0.555s)
[432.416745] Starting dynamic subtest: bcs0
[432.949595] Dynamic subtest bcs0: SUCCESS (0.550s)
[432.966674] Starting dynamic subtest: vcs0
[434.952271] Dynamic subtest vcs0: SUCCESS (1.998s)
[434.969498] Starting dynamic subtest: vcs1
[436.936915] Dynamic subtest vcs1: SUCCESS (1.980s)
[436.953712] Starting dynamic subtest: vecs0
[438.984294] Dynamic subtest vecs0: SUCCESS (2.044s)
[439.000736] Starting dynamic subtest: ccs0
[439.533505] Dynamic subtest ccs0: SUCCESS (0.548s)
[439.535965] Subtest write-busy: SUCCESS (8.318s)
[439.789789] [071/133] (583s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[439.899163] Starting subtest: y-tiled-8bpp-rotate-0
[439.903520] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[440.042298] [072/133] (583s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[440.170895] Starting subtest: basic-busy-flip-before-cursor-legacy
[440.175427] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[440.339641] [073/133] (583s left) gem_basic (bad-close)
[440.409758] Starting subtest: bad-close
[440.414259] Subtest bad-close: SUCCESS (0.000s)
[440.546095] [074/133] (583s left) kms_big_fb (linear-16bpp-rotate-0)
[440.656972] Starting subtest: linear-16bpp-rotate-0
[442.103074] Subtest linear-16bpp-rotate-0: SUCCESS (1.445s)
[442.275118] [075/133] (581s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[447.280053] Starting subtest: pr-overlay-plane-update-continuous-sf
[447.284535] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[448.163690] [076/133] (575s left) drm_read (short-buffer-wakeup)
[448.322892] Starting subtest: short-buffer-wakeup
[480.549947] Subtest short-buffer-wakeup: SUCCESS (32.217s)
[480.728690] [077/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[480.828108] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[487.863845] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.037s)
[488.031211] [078/133] (535s left) kms_psr (fbc-pr-cursor-render)
[488.139251] Starting subtest: fbc-pr-cursor-render
[488.143582] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[488.236924] [079/133] (535s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[488.338671] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[488.340968] Starting dynamic subtest: pipe-A-eDP-1
[488.349933] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[488.363910] Starting dynamic subtest: pipe-B-eDP-1
[488.373655] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[488.388385] Starting dynamic subtest: pipe-C-eDP-1
[488.397074] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[488.408130] Starting dynamic subtest: pipe-D-eDP-1
[488.416525] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[488.420511] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[490.636480] [080/133] (533s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[490.735195] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[490.737390] Starting dynamic subtest: pipe-A-eDP-1
[492.007726] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.274s)
[492.018249] Starting dynamic subtest: pipe-B-eDP-1
[494.372564] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.363s)
[494.382488] Starting dynamic subtest: pipe-C-eDP-1
[496.704841] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.328s)
[496.714722] Starting dynamic subtest: pipe-D-eDP-1
[499.048399] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.344s)
[499.050629] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.316s)
[500.282971] [081/133] (523s left) sw_sync (sync_multi_timeline_wait)
[500.320038] Starting subtest: sync_multi_timeline_wait
[500.321986] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[500.405690] [082/133] (523s left) sysfs_heartbeat_interval (idempotent)
[500.468842] Starting subtest: idempotent
[500.471116] Starting dynamic subtest: vecs0
[500.473454] Dynamic subtest vecs0: SUCCESS (0.001s)
[500.484842] Starting dynamic subtest: ccs0
[500.486726] Dynamic subtest ccs0: SUCCESS (0.001s)
[500.496106] Starting dynamic subtest: vcs0
[500.497928] Dynamic subtest vcs0: SUCCESS (0.000s)
[500.507067] Starting dynamic subtest: bcs0
[500.508877] Dynamic subtest bcs0: SUCCESS (0.001s)
[500.518063] Starting dynamic subtest: rcs0
[500.519932] Dynamic subtest rcs0: SUCCESS (0.001s)
[500.529337] Starting dynamic subtest: vcs1
[500.531250] Dynamic subtest vcs1: SUCCESS (0.000s)
[500.533153] Subtest idempotent: SUCCESS (0.008s)
[500.617344] [083/133] (523s left) syncobj_eventfd (invalid-bad-pad)
[500.674032] Starting subtest: invalid-bad-pad
[500.676204] Subtest invalid-bad-pad: SUCCESS (0.000s)
[500.789164] [084/133] (523s left) kms_busy (extended-pageflip-hang-newfb)
[500.892020] Starting subtest: extended-pageflip-hang-newfb
[500.894275] Starting dynamic subtest: pipe-A
[527.718908] Dynamic subtest pipe-A: SUCCESS (26.824s)
[527.731684] Starting dynamic subtest: pipe-D
[552.745645] Dynamic subtest pipe-D: SUCCESS (25.026s)
[552.747894] Subtest extended-pageflip-hang-newfb: SUCCESS (51.855s)
[553.641791] [085/133] (470s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[558.685238] Starting subtest: psr2-cursor-plane-update-sf
[558.687455] Starting dynamic subtest: pipe-A-eDP-1
[560.014126] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.328s)
[560.023842] Starting dynamic subtest: pipe-B-eDP-1
[561.354628] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.335s)
[561.356850] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.668s)
[562.235642] [086/133] (461s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[562.345977] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[563.003872] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.660s)
[563.225077] [087/133] (460s left) gem_exec_balancer (busy)
[563.286823] Starting subtest: busy
[564.975133] Subtest busy: SUCCESS (1.687s)
[565.340886] [088/133] (458s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[565.439349] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[565.443486] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[565.565563] [089/133] (458s left) vgem_slow (nohang)
[565.613590] Starting subtest: nohang
[576.102517] Subtest nohang: SUCCESS (10.490s)
[576.204085] [090/133] (448s left) gem_spin_batch (resubmit-new-all)
[576.273295] Starting subtest: resubmit-new-all
[576.276005] Starting dynamic subtest: rcs0
[576.302764] Dynamic subtest rcs0: SUCCESS (0.030s)
[576.313866] Starting dynamic subtest: bcs0
[576.319942] Dynamic subtest bcs0: SUCCESS (0.017s)
[576.329838] Starting dynamic subtest: vcs0
[576.337891] Dynamic subtest vcs0: SUCCESS (0.017s)
[576.347538] Starting dynamic subtest: vcs1
[576.354385] Dynamic subtest vcs1: SUCCESS (0.015s)
[576.364195] Starting dynamic subtest: vecs0
[576.374217] Dynamic subtest vecs0: SUCCESS (0.019s)
[576.383818] Starting dynamic subtest: ccs0
[576.395220] Dynamic subtest ccs0: SUCCESS (0.020s)
[576.397529] Subtest resubmit-new-all: SUCCESS (0.123s)
[577.997809] [091/133] (446s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[578.069296] Starting subtest: mixed-tiled-to-y-tiled-ccs
[578.073755] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[578.285507] [092/133] (446s left) syncobj_timeline (invalid-signal-illegal-point)
[578.337378] Starting subtest: invalid-signal-illegal-point
[578.339704] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[578.478357] [093/133] (445s left) gem_exec_schedule (preempt-contexts)
[578.546293] Starting subtest: preempt-contexts
[578.548345] Starting dynamic subtest: rcs0
[578.629760] Dynamic subtest rcs0: SUCCESS (0.089s)
[578.640898] Starting dynamic subtest: bcs0
[578.704891] Dynamic subtest bcs0: SUCCESS (0.074s)
[578.715988] Starting dynamic subtest: vcs0
[578.783049] Dynamic subtest vcs0: SUCCESS (0.076s)
[578.794418] Starting dynamic subtest: vcs1
[578.834433] Dynamic subtest vcs1: SUCCESS (0.052s)
[578.844545] Starting dynamic subtest: vecs0
[578.903910] Dynamic subtest vecs0: SUCCESS (0.068s)
[578.914044] Starting dynamic subtest: ccs0
[578.986287] Dynamic subtest ccs0: SUCCESS (0.082s)
[578.988650] Subtest preempt-contexts: SUCCESS (0.447s)
[580.110616] [094/133] (444s left) gem_pwrite_snooped
[580.277031] [095/133] (444s left) kms_tiled_display (basic-test-pattern)
[580.390559] Subtest basic-test-pattern: SKIP (0.000s)
[580.440278] [096/133] (444s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[580.532879] Starting subtest: psr-shrfb-scaledprimary
[586.304079] Subtest psr-shrfb-scaledprimary: SUCCESS (5.774s)
[586.441701] [097/133] (438s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[586.550353] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[586.554573] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[586.666697] [098/133] (437s left) gem_pwrite (basic-self)
[586.740992] Subtest basic-self: SKIP (0.000s)
[586.810161] [099/133] (437s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[589.136899] Starting subtest: dpms-mode-unset-non-lpsp
[590.286910] Subtest dpms-mode-unset-non-lpsp: SKIP (1.149s)
[590.688780] [100/133] (434s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[590.786894] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[590.791123] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[590.931178] [101/133] (433s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[591.030958] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[591.034996] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[591.138973] [102/133] (433s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[591.233775] Starting subtest: plane-lut1d-ctm3x4-lut1d
[591.250289] Starting dynamic subtest: pipe-A-eDP-1
[591.920763] Dynamic subtest pipe-A-eDP-1: FAIL (0.343s)
[592.632744] Starting dynamic subtest: pipe-B-eDP-1
[593.487206] Dynamic subtest pipe-B-eDP-1: FAIL (0.324s)
[594.075100] Starting dynamic subtest: pipe-C-eDP-1
[594.940163] Dynamic subtest pipe-C-eDP-1: FAIL (0.280s)
[595.417802] Starting dynamic subtest: pipe-D-eDP-1
[596.289755] Dynamic subtest pipe-D-eDP-1: FAIL (0.290s)
[596.291786] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.765s)
[596.825166] [103/133] (428s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[596.943104] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[603.725489] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.794s)
[603.914557] [104/133] (420s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[604.022917] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[611.055596] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.037s)
[611.215656] [105/133] (413s left) gem_exec_schedule (preempt-queue-contexts-chain)
[611.296391] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[611.602501] [106/133] (413s left) api_intel_bb (object-noreloc-keep-cache-simple)
[611.663101] Starting subtest: object-noreloc-keep-cache-simple
[611.665977] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[611.838866] [107/133] (413s left) gem_mmap (bad-object)
[611.905559] Subtest bad-object: SKIP (0.000s)
[611.979075] [108/133] (413s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[612.084406] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[612.086637] Starting dynamic subtest: pipe-A-default-mode
[612.375534] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[612.379795] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.290s)
[613.200735] [109/133] (411s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[613.298365] Starting subtest: bo-too-small-due-to-tiling
[613.302509] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[613.438233] [110/133] (411s left) kms_psr (pr-sprite-blt)
[613.534726] Starting subtest: pr-sprite-blt
[613.538846] Subtest pr-sprite-blt: SKIP (0.000s)
[613.640979] [111/133] (411s left) kms_draw_crc (fill-fb)
[613.735945] Starting subtest: fill-fb
[614.198129] Subtest fill-fb: SUCCESS (0.464s)
[614.320187] [112/133] (410s left) perf_pmu (busy-idle)
[614.362576] Starting subtest: busy-idle
[614.364762] Starting dynamic subtest: rcs0
[615.079015] Dynamic subtest rcs0: SUCCESS (0.717s)
[615.091541] Starting dynamic subtest: bcs0
[615.754033] Dynamic subtest bcs0: SUCCESS (0.673s)
[615.766784] Starting dynamic subtest: vcs0
[616.969237] Dynamic subtest vcs0: SUCCESS (1.211s)
[616.982055] Starting dynamic subtest: vcs1
[618.953112] Dynamic subtest vcs1: SUCCESS (1.981s)
[618.965955] Starting dynamic subtest: vecs0
[620.937644] Dynamic subtest vecs0: SUCCESS (1.981s)
[620.950224] Starting dynamic subtest: ccs0
[621.607026] Dynamic subtest ccs0: SUCCESS (0.669s)
[621.609829] Subtest busy-idle: SUCCESS (7.247s)
[621.750574] [113/133] (403s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[621.846994] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[621.849118] Starting dynamic subtest: pipe-A-eDP-1
[621.905720] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[621.917580] Starting dynamic subtest: pipe-B-eDP-1
[621.974421] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[621.985905] Starting dynamic subtest: pipe-C-eDP-1
[622.042357] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[622.053233] Starting dynamic subtest: pipe-D-eDP-1
[622.109637] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[622.113924] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[624.140816] [114/133] (401s left) gem_exec_flush (basic-batch-kernel-default-uc)
[624.210156] Starting subtest: basic-batch-kernel-default-uc
[631.407150] Subtest basic-batch-kernel-default-uc: SUCCESS (7.199s)
[631.618678] [115/133] (393s left) gem_mmap_wc (write-read-distinct)
[631.682119] Subtest write-read-distinct: SKIP (0.000s)
[631.748571] [116/133] (393s left) kms_plane_lowres (tiling-x)
[631.861495] Starting subtest: tiling-x
[631.863723] Starting dynamic subtest: pipe-A-eDP-1
[631.868370] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[632.157250] Starting dynamic subtest: pipe-B-eDP-1
[632.161874] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[632.171965] Starting dynamic subtest: pipe-C-eDP-1
[632.176635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[632.186322] Starting dynamic subtest: pipe-D-eDP-1
[632.190568] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[632.194855] Subtest tiling-x: SKIP (0.294s)
[632.974876] [117/133] (392s left) sw_sync (alloc_merge_fence)
[633.011965] Starting subtest: alloc_merge_fence
[633.013875] Subtest alloc_merge_fence: SUCCESS (0.000s)
[633.091637] [118/133] (392s left) kms_pm_backlight (fade)
[633.190486] Starting subtest: fade
[633.242207] Starting dynamic subtest: eDP-1
[635.931449] Dynamic subtest eDP-1: SUCCESS (2.690s)
[635.933722] Subtest fade: SUCCESS (2.742s)
[636.801277] [119/133] (388s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[636.882357] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[636.884565] Starting dynamic subtest: pipe-A-default-mode
[638.038384] Dynamic subtest pipe-A-default-mode: SKIP (1.153s)
[638.042287] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.155s)
[638.235137] [120/133] (387s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[638.299650] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[638.405285] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[638.505958] [121/133] (387s left) kms_psr (psr-cursor-mmap-cpu)
[638.607897] Starting subtest: psr-cursor-mmap-cpu
[638.610194] Starting dynamic subtest: eDP-1
[640.293236] Dynamic subtest eDP-1: SUCCESS (1.686s)
[640.295855] Subtest psr-cursor-mmap-cpu: SUCCESS (1.687s)
[641.181648] [122/133] (384s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[641.282602] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[641.940337] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[642.152009] [123/133] (383s left) gem_exec_whisper (basic-queues-priority-all)
[642.227565] Starting subtest: basic-queues-priority-all
[666.180077] Subtest basic-queues-priority-all: SUCCESS (23.957s)
[666.392020] [124/133] (359s left) syncobj_timeline (etime-single-wait-all-submitted)
[666.440809] Starting subtest: etime-single-wait-all-submitted
[666.549359] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[666.653923] [125/133] (359s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[666.764718] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[666.768861] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[666.910382] [126/133] (358s left) kms_async_flips (async-flip-dpms)
[666.993435] Starting subtest: async-flip-dpms
[667.379340] Starting dynamic subtest: pipe-A-eDP-1
[671.167360] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.789s)
[671.562980] Starting dynamic subtest: pipe-B-eDP-1
[674.327024] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.772s)
[674.727178] Starting dynamic subtest: pipe-C-eDP-1
[677.484190] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[677.859451] Starting dynamic subtest: pipe-D-eDP-1
[680.645360] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.794s)
[680.647655] Subtest async-flip-dpms: SUCCESS (13.656s)
[681.845285] [127/133] (344s left) gem_exec_reloc (basic-cpu-read-noreloc)
[681.904394] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[682.021428] [128/133] (343s left) syncobj_wait (invalid-reset-illegal-handle)
[682.086044] Starting subtest: invalid-reset-illegal-handle
[682.088389] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[682.225764] [129/133] (343s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[682.286892] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[682.389676] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[682.494250] [130/133] (343s left) gem_tiled_swapping (non-threaded)
[682.561023] Subtest non-threaded: SKIP (0.000s)
[682.625473] [131/133] (343s left) gem_exec_fence (syncobj-timeline-chain-engines)
[683.169207] Starting subtest: syncobj-timeline-chain-engines
[683.286681] Subtest syncobj-timeline-chain-engines: SUCCESS (0.118s)
[685.072540] [132/133] (341s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[685.191915] Starting subtest: flip-vs-cursor-legacy
[692.278769] Subtest flip-vs-cursor-legacy: SUCCESS (7.085s)
[693.175756] [133/133] (333s left) syncobj_basic (illegal-fd-to-handle)
[693.238785] Starting subtest: illegal-fd-to-handle
[693.241013] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[693.365501] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_suspend
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_chamelium_color
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: drm_read
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_close
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_debugfs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_big
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy_redux
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_request_retire
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_fenced_exec_thrash
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_atomic
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: syncobj_eventfd
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: vgem_slow
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_tiled_display
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_pwrite
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_tiled_swapping
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: syncobj_basic
Done.