[62.117633] Initializing watchdogs
[62.117677]   /dev/watchdog0
[62.132018] [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]
[62.136237] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.138338] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.141644] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[62.278652] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[62.282644] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.392614] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[62.466839] Starting subtest: basic-S3-devices
[62.469325] Starting dynamic subtest: smem
[73.877972] Dynamic subtest smem: SUCCESS (11.441s)
[73.880842] Subtest basic-S3-devices: SUCCESS (11.442s)
[74.085172] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[74.165796] Starting subtest: y-tiled-ccs-to-yf-tiled
[74.170277] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[74.366556] [004/133] (948s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[74.466613] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[74.468920] Starting dynamic subtest: pipe-A-eDP-1
[74.491109] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.500447] Starting dynamic subtest: pipe-B-eDP-1
[74.521361] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.528845] Starting dynamic subtest: pipe-C-eDP-1
[74.549711] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.557294] Starting dynamic subtest: pipe-D-eDP-1
[74.578608] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.582982] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[76.691276] [005/133] (946s left) kms_flip (bo-too-big)
[76.790247] Starting subtest: bo-too-big
[76.792554] Starting dynamic subtest: A-eDP1
[78.105485] Dynamic subtest A-eDP1: SUCCESS (1.316s)
[78.119721] Starting dynamic subtest: B-eDP1
[79.435487] Dynamic subtest B-eDP1: SUCCESS (1.329s)
[79.445392] Starting dynamic subtest: C-eDP1
[80.767566] Dynamic subtest C-eDP1: SUCCESS (1.332s)
[80.775759] Starting dynamic subtest: D-eDP1
[82.091156] Dynamic subtest D-eDP1: SUCCESS (1.323s)
[82.093570] Subtest bo-too-big: SUCCESS (5.308s)
[83.326980] [006/133] (939s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[83.387759] Starting subtest: multi-wait-available-unsubmitted-signaled
[83.389666] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[83.524395] [007/133] (939s left) kms_lease (lease-uevent)
[83.617921] Starting subtest: lease-uevent
[84.633580] Subtest lease-uevent: SUCCESS (1.017s)
[84.729687] [008/133] (938s left) gem_exec_fence (syncobj-timeline-wait)
[85.319036] Starting subtest: syncobj-timeline-wait
[86.924184] Subtest syncobj-timeline-wait: SUCCESS (1.606s)
[87.191447] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[87.194518] [009/133] (935s left) kms_chamelium_color (gamma)
[87.305475] Subtest gamma: SKIP (0.000s)
[87.348115] [010/133] (935s left) prime_mmap (test_errors)
[87.408870] Starting subtest: test_errors
[87.410908] Starting dynamic subtest: test_errors-smem
[87.502985] Dynamic subtest test_errors-smem: SUCCESS (0.096s)
[87.505548] Subtest test_errors: SUCCESS (0.096s)
[87.622361] [011/133] (935s left) i915_drm_fdinfo (idle)
[87.661599] Starting subtest: idle
[87.663895] Starting dynamic subtest: rcs0
[88.246395] Dynamic subtest rcs0: SUCCESS (0.584s)
[88.256927] Starting dynamic subtest: bcs0
[88.752487] Dynamic subtest bcs0: SUCCESS (0.504s)
[88.763486] Starting dynamic subtest: vcs0
[89.257578] Dynamic subtest vcs0: SUCCESS (0.504s)
[89.268244] Starting dynamic subtest: vcs1
[89.765588] Dynamic subtest vcs1: SUCCESS (0.504s)
[89.775888] Starting dynamic subtest: vecs0
[90.267437] Dynamic subtest vecs0: SUCCESS (0.504s)
[90.278975] Starting dynamic subtest: ccs0
[90.772233] Dynamic subtest ccs0: SUCCESS (0.504s)
[90.775030] Subtest idle: SUCCESS (3.110s)
[90.874834] [012/133] (932s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[90.971320] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[90.975327] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[91.083949] [013/133] (932s left) kms_invalid_mode (zero-hdisplay)
[91.175751] Starting subtest: zero-hdisplay
[91.178074] Starting dynamic subtest: pipe-A-eDP-1
[91.454354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[91.464018] Starting dynamic subtest: pipe-B-eDP-1
[91.465943] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[91.476698] Starting dynamic subtest: pipe-C-eDP-1
[91.478867] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[91.486067] Starting dynamic subtest: pipe-D-eDP-1
[91.488208] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[91.490404] Subtest zero-hdisplay: SUCCESS (0.285s)
[92.355806] [014/133] (930s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[92.458572] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[92.460930] Starting dynamic subtest: pipe-A
[92.520756] Dynamic subtest pipe-A: SUCCESS (0.065s)
[92.537222] Starting dynamic subtest: pipe-B
[93.662023] Dynamic subtest pipe-B: SUCCESS (1.141s)
[93.673057] Starting dynamic subtest: pipe-C
[94.774075] Dynamic subtest pipe-C: SUCCESS (1.112s)
[94.782997] Starting dynamic subtest: pipe-D
[95.907081] Dynamic subtest pipe-D: SUCCESS (1.132s)
[95.909566] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.453s)
[97.075180] [015/133] (926s left) drm_read (fault-buffer)
[97.226324] Starting subtest: fault-buffer
[97.228766] Subtest fault-buffer: SUCCESS (0.000s)
[97.383938] [016/133] (925s left) gem_ccs (suspend-resume)
[97.440915] Starting subtest: suspend-resume
[97.445609] Subtest suspend-resume: SKIP (0.000s)
[97.581328] [017/133] (925s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[97.670488] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[97.672661] Starting dynamic subtest: pipe-A-eDP-1
[97.695280] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[97.703370] Starting dynamic subtest: pipe-B-eDP-1
[97.724245] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.731839] Starting dynamic subtest: pipe-C-eDP-1
[97.752554] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.760027] Starting dynamic subtest: pipe-D-eDP-1
[97.781888] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[97.785907] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[99.866401] [018/133] (923s left) gem_close (many-handles-one-vma)
[99.931591] Starting subtest: many-handles-one-vma
[99.955962] Subtest many-handles-one-vma: SUCCESS (0.025s)
[100.106762] [019/133] (923s left) gem_busy (extended)
[100.297907] Starting subtest: extended
[100.300457] Starting dynamic subtest: rcs0
[100.397782] Dynamic subtest rcs0: SUCCESS (0.100s)
[100.408853] Starting dynamic subtest: bcs0
[100.439633] Dynamic subtest bcs0: SUCCESS (0.041s)
[100.449091] Starting dynamic subtest: vcs0
[101.909477] Dynamic subtest vcs0: SUCCESS (1.467s)
[101.921474] Starting dynamic subtest: vcs1
[103.893428] Dynamic subtest vcs1: SUCCESS (1.983s)
[103.904105] Starting dynamic subtest: vecs0
[105.877595] Dynamic subtest vecs0: SUCCESS (1.983s)
[105.887907] Starting dynamic subtest: ccs0
[105.924122] Dynamic subtest ccs0: SUCCESS (0.048s)
[105.926586] Subtest extended: SUCCESS (5.627s)
[106.231189] [020/133] (917s left) kms_vblank (ts-continuation-suspend)
[106.336597] Starting subtest: ts-continuation-suspend
[106.338485] Starting dynamic subtest: pipe-A-eDP-1
[123.295477] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.524s)
[123.310909] Starting dynamic subtest: pipe-D-eDP-1
[140.280202] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.210s)
[140.282330] Subtest ts-continuation-suspend: SUCCESS (3.737s)
[141.083963] [021/133] (882s left) perf_pmu (semaphore-wait-idle)
[141.130207] Starting subtest: semaphore-wait-idle
[141.132485] Starting dynamic subtest: rcs0
[141.643543] Dynamic subtest rcs0: SUCCESS (0.531s)
[141.652660] Starting dynamic subtest: bcs0
[142.156323] Dynamic subtest bcs0: SUCCESS (0.529s)
[142.170657] Starting dynamic subtest: vcs0
[142.669254] Dynamic subtest vcs0: SUCCESS (0.527s)
[142.683167] Starting dynamic subtest: vcs1
[143.180997] Dynamic subtest vcs1: SUCCESS (0.525s)
[143.191955] Starting dynamic subtest: vecs0
[143.690283] Dynamic subtest vecs0: SUCCESS (0.523s)
[143.700027] Starting dynamic subtest: ccs0
[144.203421] Dynamic subtest ccs0: SUCCESS (0.524s)
[144.206108] Subtest semaphore-wait-idle: SUCCESS (3.166s)
[144.347754] [022/133] (879s left) kms_debugfs (display-off-read-all)
[144.457297] Starting subtest: display-off-read-all
[144.737960] Subtest display-off-read-all: SUCCESS (0.288s)
[145.584386] [023/133] (877s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[145.682217] Starting subtest: fbc-rgb101010-draw-blt
[150.229473] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.618s)
[151.407868] [024/133] (872s left) gem_ctx_param (invalid-get-no-zeromap)
[151.462251] Starting subtest: invalid-get-no-zeromap
[151.464667] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[151.595203] [025/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[151.695131] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[151.699640] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[151.820268] [026/133] (871s left) gem_exec_big (single)
[151.875929] Starting subtest: single
[154.148811] Subtest single: SUCCESS (2.288s)
[154.375361] [027/133] (869s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[154.522032] Starting subtest: psr-rgb101010-draw-mmap-gtt
[154.526278] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[154.634464] [028/133] (869s left) gem_exec_flush (basic-uc-prw-default)
[154.702884] Starting subtest: basic-uc-prw-default
[160.148083] Subtest basic-uc-prw-default: SUCCESS (5.471s)
[160.357282] [029/133] (863s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[160.470365] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[160.474776] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[160.617680] [030/133] (863s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[160.712728] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[167.518747] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.825s)
[167.679102] [031/133] (856s left) gem_exec_create (forked)
[167.744542] Starting subtest: forked
[167.746862] Starting dynamic subtest: smem
[189.156430] Dynamic subtest smem: SUCCESS (21.399s)
[189.159451] Subtest forked: SUCCESS (21.400s)
[189.370165] [032/133] (834s left) kms_feature_discovery (display-1x)
[189.491343] Starting subtest: display-1x
[189.493641] Subtest display-1x: SUCCESS (0.000s)
[189.590122] [033/133] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[189.680371] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[189.684434] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[189.806522] [034/133] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[189.904876] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[189.908837] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[190.024080] [035/133] (834s left) gem_render_copy_redux (interruptible)
[190.085612] Starting subtest: interruptible
[190.353519] Subtest interruptible: SUCCESS (0.269s)
[190.523329] [036/133] (833s left) i915_pm_rpm (system-suspend-execbuf)
[192.368936] Starting subtest: system-suspend-execbuf
[250.919376] Subtest system-suspend-execbuf: SUCCESS (43.306s)
[251.305697] [037/133] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[251.407003] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[251.411014] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[251.546498] [038/133] (772s left) gem_request_retire (retire-vma-not-inactive)
[251.613095] Starting subtest: retire-vma-not-inactive
[251.671420] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[251.807421] [039/133] (772s left) i915_pm_rps (thresholds-idle)
[251.889052] Starting subtest: thresholds-idle
[251.893493] Subtest thresholds-idle: SKIP (0.001s)
[252.019183] [040/133] (772s left) gem_ctx_persistence (legacy-engines-queued)
[252.076187] Starting subtest: legacy-engines-queued
[252.078576] Starting dynamic subtest: render
[252.156819] Dynamic subtest render: SUCCESS (0.080s)
[252.168900] Starting dynamic subtest: bsd1
[253.705570] Dynamic subtest bsd1: SUCCESS (1.545s)
[253.718011] Starting dynamic subtest: bsd2
[255.687361] Dynamic subtest bsd2: SUCCESS (1.980s)
[255.699679] Starting dynamic subtest: blt
[255.792383] Dynamic subtest blt: SUCCESS (0.104s)
[255.804299] Starting dynamic subtest: vebox
[257.735836] Dynamic subtest vebox: SUCCESS (1.941s)
[257.739237] Subtest legacy-engines-queued: SUCCESS (5.662s)
[257.902330] [041/133] (766s left) i915_hangman (gt-error-state-capture)
[257.972268] Starting subtest: gt-error-state-capture
[257.974495] Starting dynamic subtest: rcs0
[269.640065] Dynamic subtest rcs0: SUCCESS (11.674s)
[269.653100] Starting dynamic subtest: bcs0
[279.687444] Dynamic subtest bcs0: SUCCESS (10.051s)
[279.707789] Starting dynamic subtest: vcs0
[290.695904] Dynamic subtest vcs0: SUCCESS (11.012s)
[290.716402] Starting dynamic subtest: vcs1
[302.663381] Dynamic subtest vcs1: SUCCESS (11.972s)
[302.678532] Starting dynamic subtest: vecs0
[314.695532] Dynamic subtest vecs0: SUCCESS (12.026s)
[314.707402] Starting dynamic subtest: ccs0
[326.726859] Dynamic subtest ccs0: SUCCESS (12.025s)
[326.729910] Subtest gt-error-state-capture: SUCCESS (68.770s)
[326.888106] [042/133] (697s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[327.119698] Starting subtest: cursor-rapid-movement-128x42
[327.169859] Subtest cursor-rapid-movement-128x42: SKIP (0.044s)
[327.404953] [043/133] (696s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[327.476096] Subtest writes-after-reads-uncached: SKIP (0.000s)
[327.551684] [044/133] (696s left) gem_mmap_wc (coherency)
[327.606153] Subtest coherency: SKIP (0.000s)
[327.670095] [045/133] (696s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[327.735317] Starting subtest: single-wait-all-for-submit-signaled
[327.737731] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[327.836278] [046/133] (696s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[327.938238] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[331.663866] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.727s)
[332.885332] [047/133] (691s left) kms_psr (fbc-psr-primary-mmap-cpu)
[332.981137] Starting subtest: fbc-psr-primary-mmap-cpu
[332.983088] Starting dynamic subtest: eDP-1
[332.987247] Dynamic subtest eDP-1: SKIP (0.000s)
[332.991391] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[333.077901] [048/133] (691s left) kms_invalid_mode (bad-vsync-start)
[333.185344] Starting subtest: bad-vsync-start
[333.187689] Starting dynamic subtest: pipe-A-eDP-1
[333.478175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[333.488277] Starting dynamic subtest: pipe-B-eDP-1
[333.490140] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[333.499486] Starting dynamic subtest: pipe-C-eDP-1
[333.501666] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[333.510914] Starting dynamic subtest: pipe-D-eDP-1
[333.513626] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[333.516103] Subtest bad-vsync-start: SUCCESS (0.298s)
[334.292974] [049/133] (690s left) gem_exec_reloc (basic-wc-gtt)
[334.355549] Subtest basic-wc-gtt: SKIP (0.000s)
[334.433291] [050/133] (690s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[334.489595] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[334.548332] [051/133] (690s left) kms_prop_blob (blob-multiple)
[334.610407] Starting subtest: blob-multiple
[334.612745] Subtest blob-multiple: SUCCESS (0.002s)
[334.752216] [052/133] (689s left) api_intel_allocator (open-vm)
[334.819051] Starting subtest: open-vm
[334.821385] Subtest open-vm: SUCCESS (0.003s)
[334.988289] [053/133] (689s left) kms_getfb (getfb-repeated-different-handles)
[335.093838] Starting subtest: getfb-repeated-different-handles
[335.096152] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[335.232921] [054/133] (689s left) kms_content_protection (legacy-hdcp14)
[335.382315] Starting subtest: legacy-hdcp14
[335.386262] Subtest legacy-hdcp14: SKIP (0.000s)
[335.572775] [055/133] (689s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[335.962562] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[336.784910] [056/133] (688s left) kms_flip (blocking-absolute-wf_vblank)
[336.887445] Starting subtest: blocking-absolute-wf_vblank
[336.889843] Starting dynamic subtest: A-eDP1
[345.663826] Dynamic subtest A-eDP1: SUCCESS (8.778s)
[345.673557] Starting dynamic subtest: B-eDP1
[354.395359] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[354.407731] Starting dynamic subtest: C-eDP1
[363.105687] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[363.121797] Starting dynamic subtest: D-eDP1
[371.827409] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[371.832583] Subtest blocking-absolute-wf_vblank: SUCCESS (34.952s)
[373.067397] [057/133] (651s left) gem_mmap_offset (bad-object)
[373.135343] Starting subtest: bad-object
[373.137639] Subtest bad-object: SUCCESS (0.002s)
[373.268755] [058/133] (651s left) kms_psr (psr2-no-drrs)
[373.352744] Starting subtest: psr2-no-drrs
[373.354971] Starting dynamic subtest: eDP-1
[374.944042] Dynamic subtest eDP-1: SUCCESS (1.592s)
[374.946383] Subtest psr2-no-drrs: SUCCESS (1.593s)
[375.768428] [059/133] (649s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[375.826724] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[375.913871] [060/133] (649s left) kms_vblank (wait-idle)
[376.009306] Starting subtest: wait-idle
[376.011638] Starting dynamic subtest: pipe-A-eDP-1
[377.782768] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.771s)
[377.797864] Starting dynamic subtest: pipe-D-eDP-1
[380.193410] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.410s)
[380.195748] Subtest wait-idle: SUCCESS (4.185s)
[381.031074] [061/133] (644s left) gem_exec_whisper (basic-contexts-all)
[381.097684] Starting subtest: basic-contexts-all
[391.944426] Subtest basic-contexts-all: SUCCESS (10.846s)
[392.157285] [062/133] (633s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[392.281976] Starting subtest: x-tiled-16bpp-rotate-0
[393.648324] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.368s)
[393.817926] [063/133] (631s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[393.912404] Starting subtest: plane-primary-overlay-mutable-zpos
[397.334862] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.421s)
[398.543776] [064/133] (626s left) gen9_exec_parse (bb-start-cmd)
[398.617347] Subtest bb-start-cmd: SKIP (0.000s)
[398.694141] [065/133] (626s left) kms_cursor_crc (cursor-alpha-opaque)
[398.790927] Starting subtest: cursor-alpha-opaque
[398.792890] Starting dynamic subtest: pipe-A-eDP-1
[399.397244] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[399.408285] Starting dynamic subtest: pipe-D-eDP-1
[400.687158] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.287s)
[400.689447] Subtest cursor-alpha-opaque: SUCCESS (1.897s)
[401.504849] [066/133] (623s left) kms_cursor_crc (cursor-sliding-64x64)
[401.696349] Starting subtest: cursor-sliding-64x64
[401.699258] Starting dynamic subtest: pipe-A-eDP-1
[404.920569] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.223s)
[404.949543] Starting dynamic subtest: pipe-D-eDP-1
[408.776736] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.834s)
[408.778966] Subtest cursor-sliding-64x64: SUCCESS (7.083s)
[409.605450] [067/133] (615s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[409.716821] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[416.414473] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.703s)
[416.577089] [068/133] (608s left) gem_ctx_shared (exec-single-timeline)
[416.637398] Starting subtest: exec-single-timeline
[416.639803] Starting dynamic subtest: rcs0
[417.668745] Dynamic subtest rcs0: SUCCESS (1.029s)
[417.681462] Starting dynamic subtest: bcs0
[418.757470] Dynamic subtest bcs0: SUCCESS (1.086s)
[418.769455] Starting dynamic subtest: vcs0
[419.846278] Dynamic subtest vcs0: SUCCESS (1.086s)
[419.859533] Starting dynamic subtest: vcs1
[420.934715] Dynamic subtest vcs1: SUCCESS (1.085s)
[420.947930] Starting dynamic subtest: vecs0
[422.021889] Dynamic subtest vecs0: SUCCESS (1.085s)
[422.035537] Starting dynamic subtest: ccs0
[423.110447] Dynamic subtest ccs0: SUCCESS (1.086s)
[423.113610] Subtest exec-single-timeline: SUCCESS (6.475s)
[423.864593] [069/133] (601s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[423.980841] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[423.983107] Starting dynamic subtest: pipe-A
[425.152370] Dynamic subtest pipe-A: SUCCESS (1.173s)
[425.168807] Starting dynamic subtest: pipe-B
[427.386763] Dynamic subtest pipe-B: SUCCESS (2.234s)
[427.397799] Starting dynamic subtest: pipe-C
[428.582791] Dynamic subtest pipe-C: SUCCESS (1.195s)
[428.592746] Starting dynamic subtest: pipe-D
[429.728935] Dynamic subtest pipe-D: SUCCESS (1.146s)
[429.731251] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.753s)
[430.933036] [070/133] (594s left) gem_wait (write-busy)
[430.999772] Starting subtest: write-busy
[431.002270] Starting dynamic subtest: all-engines
[431.637045] Dynamic subtest all-engines: SUCCESS (0.637s)
[431.653758] Starting dynamic subtest: rcs0
[432.191161] Dynamic subtest rcs0: SUCCESS (0.553s)
[432.208649] Starting dynamic subtest: bcs0
[432.744993] Dynamic subtest bcs0: SUCCESS (0.551s)
[432.761128] Starting dynamic subtest: vcs0
[434.728419] Dynamic subtest vcs0: SUCCESS (1.978s)
[434.745715] Starting dynamic subtest: vcs1
[436.776077] Dynamic subtest vcs1: SUCCESS (2.042s)
[436.792055] Starting dynamic subtest: vecs0
[438.760362] Dynamic subtest vecs0: SUCCESS (1.979s)
[438.777676] Starting dynamic subtest: ccs0
[439.310452] Dynamic subtest ccs0: SUCCESS (0.548s)
[439.312817] Subtest write-busy: SUCCESS (8.304s)
[439.532812] [071/133] (586s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[439.638408] Starting subtest: y-tiled-8bpp-rotate-0
[439.642647] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[439.769434] [072/133] (585s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[439.888606] Starting subtest: basic-busy-flip-before-cursor-legacy
[439.893206] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[440.060821] [073/133] (585s left) gem_basic (bad-close)
[440.128721] Starting subtest: bad-close
[440.133261] Subtest bad-close: SUCCESS (0.000s)
[440.262705] [074/133] (585s left) kms_big_fb (linear-16bpp-rotate-0)
[440.372271] Starting subtest: linear-16bpp-rotate-0
[441.774500] Subtest linear-16bpp-rotate-0: SUCCESS (1.401s)
[441.932182] [075/133] (583s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[446.917006] Starting subtest: pr-overlay-plane-update-continuous-sf
[446.921484] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[447.776667] [076/133] (577s left) drm_read (short-buffer-wakeup)
[447.957828] Starting subtest: short-buffer-wakeup
[480.187340] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[480.359057] [077/133] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[480.465660] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[487.333612] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.868s)
[487.503892] [078/133] (538s left) kms_psr (fbc-pr-cursor-render)
[487.614411] Starting subtest: fbc-pr-cursor-render
[487.619068] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[487.718521] [079/133] (538s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[487.820930] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[487.823311] Starting dynamic subtest: pipe-A-eDP-1
[487.832392] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[487.842805] Starting dynamic subtest: pipe-B-eDP-1
[487.851856] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[487.860952] Starting dynamic subtest: pipe-C-eDP-1
[487.870296] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[487.879461] Starting dynamic subtest: pipe-D-eDP-1
[487.888154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[487.892304] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[490.056871] [080/133] (535s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[490.142173] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[490.144114] Starting dynamic subtest: pipe-A-eDP-1
[491.354468] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.212s)
[491.363940] Starting dynamic subtest: pipe-B-eDP-1
[493.664776] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.311s)
[493.675777] Starting dynamic subtest: pipe-C-eDP-1
[495.977910] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.312s)
[495.988095] Starting dynamic subtest: pipe-D-eDP-1
[498.278711] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.299s)
[498.281094] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.139s)
[499.483976] [081/133] (526s left) sw_sync (sync_multi_timeline_wait)
[499.521929] Starting subtest: sync_multi_timeline_wait
[499.524612] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[499.602881] [082/133] (526s left) sysfs_heartbeat_interval (idempotent)
[499.664823] Starting subtest: idempotent
[499.667186] Starting dynamic subtest: vecs0
[499.669613] Dynamic subtest vecs0: SUCCESS (0.001s)
[499.681338] Starting dynamic subtest: ccs0
[499.683483] Dynamic subtest ccs0: SUCCESS (0.001s)
[499.693835] Starting dynamic subtest: vcs0
[499.695753] Dynamic subtest vcs0: SUCCESS (0.000s)
[499.704348] Starting dynamic subtest: bcs0
[499.706275] Dynamic subtest bcs0: SUCCESS (0.001s)
[499.714672] Starting dynamic subtest: rcs0
[499.716575] Dynamic subtest rcs0: SUCCESS (0.000s)
[499.725433] Starting dynamic subtest: vcs1
[499.727648] Dynamic subtest vcs1: SUCCESS (0.001s)
[499.729931] Subtest idempotent: SUCCESS (0.008s)
[499.801559] [083/133] (526s left) syncobj_eventfd (invalid-bad-pad)
[499.873992] Starting subtest: invalid-bad-pad
[499.876314] Subtest invalid-bad-pad: SUCCESS (0.000s)
[500.000234] [084/133] (526s left) kms_busy (extended-pageflip-hang-newfb)
[500.099946] Starting subtest: extended-pageflip-hang-newfb
[500.102454] Starting dynamic subtest: pipe-A
[526.526545] Dynamic subtest pipe-A: SUCCESS (26.428s)
[526.545720] Starting dynamic subtest: pipe-D
[541.490637] Dynamic subtest pipe-D: SUCCESS (14.964s)
[541.493174] Subtest extended-pageflip-hang-newfb: SUCCESS (41.397s)
[542.334541] [085/133] (483s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[547.267097] Starting subtest: psr2-cursor-plane-update-sf
[547.269406] Starting dynamic subtest: pipe-A-eDP-1
[548.572631] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.304s)
[548.583646] Starting dynamic subtest: pipe-B-eDP-1
[549.892181] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.315s)
[549.894368] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.624s)
[550.702822] [086/133] (475s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[550.814603] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[551.472121] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[551.680150] [087/133] (474s left) gem_exec_balancer (busy)
[551.743574] Starting subtest: busy
[553.775698] Subtest busy: SUCCESS (2.030s)
[554.135118] [088/133] (472s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[554.254395] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[554.258794] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[554.385165] [089/133] (471s left) vgem_slow (nohang)
[554.433075] Starting subtest: nohang
[564.614489] Subtest nohang: SUCCESS (10.181s)
[564.707779] [090/133] (461s left) gem_spin_batch (resubmit-new-all)
[564.773376] Starting subtest: resubmit-new-all
[564.775827] Starting dynamic subtest: rcs0
[564.794782] Dynamic subtest rcs0: SUCCESS (0.021s)
[564.806357] Starting dynamic subtest: bcs0
[564.811886] Dynamic subtest bcs0: SUCCESS (0.015s)
[564.822492] Starting dynamic subtest: vcs0
[564.832005] Dynamic subtest vcs0: SUCCESS (0.020s)
[564.846810] Starting dynamic subtest: vcs1
[564.852527] Dynamic subtest vcs1: SUCCESS (0.017s)
[564.864725] Starting dynamic subtest: vecs0
[564.867091] Dynamic subtest vecs0: SUCCESS (0.013s)
[564.876514] Starting dynamic subtest: ccs0
[564.881085] Dynamic subtest ccs0: SUCCESS (0.016s)
[564.883320] Subtest resubmit-new-all: SUCCESS (0.108s)
[566.828204] [091/133] (459s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[566.904354] Starting subtest: mixed-tiled-to-y-tiled-ccs
[566.908623] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[567.117016] [092/133] (459s left) syncobj_timeline (invalid-signal-illegal-point)
[567.185088] Starting subtest: invalid-signal-illegal-point
[567.187472] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[567.322892] [093/133] (459s left) gem_exec_schedule (preempt-contexts)
[567.402678] Starting subtest: preempt-contexts
[567.404816] Starting dynamic subtest: rcs0
[567.536215] Dynamic subtest rcs0: SUCCESS (0.139s)
[567.551426] Starting dynamic subtest: bcs0
[567.624154] Dynamic subtest bcs0: SUCCESS (0.087s)
[567.633885] Starting dynamic subtest: vcs0
[567.682338] Dynamic subtest vcs0: SUCCESS (0.057s)
[567.694275] Starting dynamic subtest: vcs1
[567.754208] Dynamic subtest vcs1: SUCCESS (0.071s)
[567.764355] Starting dynamic subtest: vecs0
[567.809245] Dynamic subtest vecs0: SUCCESS (0.054s)
[567.818629] Starting dynamic subtest: ccs0
[567.889903] Dynamic subtest ccs0: SUCCESS (0.080s)
[567.892213] Subtest preempt-contexts: SUCCESS (0.494s)
[568.889051] [094/133] (457s left) gem_pwrite_snooped
[569.041567] [095/133] (457s left) kms_tiled_display (basic-test-pattern)
[569.164825] Subtest basic-test-pattern: SKIP (0.000s)
[569.213570] [096/133] (457s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[569.314556] Starting subtest: psr-shrfb-scaledprimary
[575.113513] Subtest psr-shrfb-scaledprimary: SUCCESS (5.800s)
[575.262619] [097/133] (451s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[575.371828] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[575.376178] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[575.501000] [098/133] (451s left) gem_pwrite (basic-self)
[575.558766] Subtest basic-self: SKIP (0.000s)
[575.629484] [099/133] (451s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[577.956815] Starting subtest: dpms-mode-unset-non-lpsp
[579.101474] Subtest dpms-mode-unset-non-lpsp: SKIP (1.145s)
[579.485706] [100/133] (447s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[579.592921] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[579.597478] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[579.710965] [101/133] (447s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[579.802751] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[579.806941] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[579.924630] [102/133] (446s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[580.033192] Starting subtest: plane-lut1d-ctm3x4-lut1d
[580.048675] Starting dynamic subtest: pipe-A-eDP-1
[580.733134] Dynamic subtest pipe-A-eDP-1: FAIL (0.354s)
[581.526449] Starting dynamic subtest: pipe-B-eDP-1
[582.394547] Dynamic subtest pipe-B-eDP-1: FAIL (0.335s)
[582.949128] Starting dynamic subtest: pipe-C-eDP-1
[583.766133] Dynamic subtest pipe-C-eDP-1: FAIL (0.236s)
[584.269960] Starting dynamic subtest: pipe-D-eDP-1
[585.093783] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[585.096193] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.762s)
[585.680683] [103/133] (441s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[585.787523] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[592.418383] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.631s)
[592.581885] [104/133] (434s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[592.675273] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[599.670337] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.995s)
[599.832812] [105/133] (427s left) gem_exec_schedule (preempt-queue-contexts-chain)
[599.899534] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[600.231536] [106/133] (426s left) api_intel_bb (object-noreloc-keep-cache-simple)
[600.294805] Starting subtest: object-noreloc-keep-cache-simple
[600.302533] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.009s)
[600.483069] [107/133] (426s left) gem_mmap (bad-object)
[600.544065] Subtest bad-object: SKIP (0.000s)
[600.601141] [108/133] (426s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[600.708723] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[600.711214] Starting dynamic subtest: pipe-A-default-mode
[600.996089] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[601.000716] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.289s)
[601.823722] [109/133] (425s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[601.927011] Starting subtest: bo-too-small-due-to-tiling
[601.931462] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[602.058568] [110/133] (425s left) kms_psr (pr-sprite-blt)
[602.165992] Starting subtest: pr-sprite-blt
[602.170408] Subtest pr-sprite-blt: SKIP (0.000s)
[602.267917] [111/133] (425s left) kms_draw_crc (fill-fb)
[602.368948] Starting subtest: fill-fb
[602.888045] Subtest fill-fb: SUCCESS (0.520s)
[603.028006] [112/133] (424s left) perf_pmu (busy-idle)
[603.074649] Starting subtest: busy-idle
[603.076562] Starting dynamic subtest: rcs0
[603.793652] Dynamic subtest rcs0: SUCCESS (0.718s)
[603.805560] Starting dynamic subtest: bcs0
[604.465419] Dynamic subtest bcs0: SUCCESS (0.669s)
[604.477748] Starting dynamic subtest: vcs0
[605.735842] Dynamic subtest vcs0: SUCCESS (1.266s)
[605.748143] Starting dynamic subtest: vcs1
[607.785112] Dynamic subtest vcs1: SUCCESS (2.046s)
[607.797474] Starting dynamic subtest: vecs0
[609.769068] Dynamic subtest vecs0: SUCCESS (1.980s)
[609.781579] Starting dynamic subtest: ccs0
[610.446099] Dynamic subtest ccs0: SUCCESS (0.676s)
[610.448556] Subtest busy-idle: SUCCESS (7.372s)
[610.572277] [113/133] (416s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[610.673694] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[610.675760] Starting dynamic subtest: pipe-A-eDP-1
[610.733470] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[610.745089] Starting dynamic subtest: pipe-B-eDP-1
[610.802334] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[610.813180] Starting dynamic subtest: pipe-C-eDP-1
[610.870516] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[610.881746] Starting dynamic subtest: pipe-D-eDP-1
[610.940462] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[610.944998] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[612.988705] [114/133] (414s left) gem_exec_flush (basic-batch-kernel-default-uc)
[613.057597] Starting subtest: basic-batch-kernel-default-uc
[620.196761] Subtest basic-batch-kernel-default-uc: SUCCESS (7.139s)
[620.418992] [115/133] (407s left) gem_mmap_wc (write-read-distinct)
[620.478543] Subtest write-read-distinct: SKIP (0.000s)
[620.536882] [116/133] (406s left) kms_plane_lowres (tiling-x)
[620.631926] Starting subtest: tiling-x
[620.634256] Starting dynamic subtest: pipe-A-eDP-1
[620.638726] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[620.931231] Starting dynamic subtest: pipe-B-eDP-1
[620.935834] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[620.944996] Starting dynamic subtest: pipe-C-eDP-1
[620.949662] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[620.958678] Starting dynamic subtest: pipe-D-eDP-1
[620.963308] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[620.967263] Subtest tiling-x: SKIP (0.300s)
[621.801080] [117/133] (405s left) sw_sync (alloc_merge_fence)
[621.842325] Starting subtest: alloc_merge_fence
[621.844515] Subtest alloc_merge_fence: SUCCESS (0.000s)
[621.926533] [118/133] (405s left) kms_pm_backlight (fade)
[622.021320] Starting subtest: fade
[622.073605] Starting dynamic subtest: eDP-1
[624.739642] Dynamic subtest eDP-1: SUCCESS (2.668s)
[624.741934] Subtest fade: SUCCESS (2.720s)
[625.646812] [119/133] (401s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[625.745074] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[625.747383] Starting dynamic subtest: pipe-A-default-mode
[626.874686] Dynamic subtest pipe-A-default-mode: SKIP (1.128s)
[626.878976] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.129s)
[627.067823] [120/133] (400s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[627.131644] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[627.237094] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[627.340605] [121/133] (400s left) kms_psr (psr-cursor-mmap-cpu)
[627.456456] Starting subtest: psr-cursor-mmap-cpu
[627.458756] Starting dynamic subtest: eDP-1
[629.145684] Dynamic subtest eDP-1: SUCCESS (1.689s)
[629.147985] Subtest psr-cursor-mmap-cpu: SUCCESS (1.690s)
[630.045356] [122/133] (397s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[630.150228] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[630.796119] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[630.997650] [123/133] (396s left) gem_exec_whisper (basic-queues-priority-all)
[631.065152] Starting subtest: basic-queues-priority-all
[654.952636] Subtest basic-queues-priority-all: SUCCESS (23.885s)
[655.160400] [124/133] (372s left) syncobj_timeline (etime-single-wait-all-submitted)
[655.215165] Starting subtest: etime-single-wait-all-submitted
[655.316084] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[655.424485] [125/133] (372s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[655.530277] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[655.534384] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[655.644122] [126/133] (372s left) kms_async_flips (async-flip-dpms)
[655.742299] Starting subtest: async-flip-dpms
[656.120616] Starting dynamic subtest: pipe-A-eDP-1
[659.925826] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.805s)
[660.292953] Starting dynamic subtest: pipe-B-eDP-1
[663.088413] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.802s)
[663.472790] Starting dynamic subtest: pipe-C-eDP-1
[666.244442] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.779s)
[666.624880] Starting dynamic subtest: pipe-D-eDP-1
[669.416230] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.800s)
[669.418609] Subtest async-flip-dpms: SUCCESS (13.676s)
[670.612052] [127/133] (357s left) gem_exec_reloc (basic-cpu-read-noreloc)
[670.685964] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[670.752920] [128/133] (357s left) syncobj_wait (invalid-reset-illegal-handle)
[670.817676] Starting subtest: invalid-reset-illegal-handle
[670.820085] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[670.937436] [129/133] (357s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[671.007594] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[671.107625] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[671.209305] [130/133] (356s left) gem_tiled_swapping (non-threaded)
[671.271695] Subtest non-threaded: SKIP (0.000s)
[671.336956] [131/133] (356s left) gem_exec_fence (syncobj-timeline-chain-engines)
[671.889126] Starting subtest: syncobj-timeline-chain-engines
[672.004662] Subtest syncobj-timeline-chain-engines: SUCCESS (0.115s)
[672.877069] [132/133] (355s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[672.991146] Starting subtest: flip-vs-cursor-legacy
[679.961825] Subtest flip-vs-cursor-legacy: SUCCESS (6.971s)
[680.836402] [133/133] (347s left) syncobj_basic (illegal-fd-to-handle)
[680.901968] Starting subtest: illegal-fd-to-handle
[680.904381] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[681.031793] 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.