[60.839650] Initializing watchdogs
[60.839780]   /dev/watchdog0
[60.855208] [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]
[60.859548] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.861928] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.865467] [001/133] (960s left) gem_exec_schedule (reorder-wide)
[61.072063] Subtest reorder-wide: SKIP (0.000s)
[61.279389] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[61.399294] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[61.403383] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[61.536328] [003/133] (959s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-gtt)
[61.655189] Starting subtest: fbcpsr-argb161616f-draw-mmap-gtt
[61.659151] Subtest fbcpsr-argb161616f-draw-mmap-gtt: SKIP (0.000s)
[61.778745] [004/133] (959s left) gem_mmap_offset (isolation)
[61.849852] Starting subtest: isolation
[61.868068] Subtest isolation: SUCCESS (0.007s)
[61.996994] [005/133] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[62.099949] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[62.104383] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[62.223709] [006/133] (959s left) gen7_exec_parse (basic-rejected)
[62.276639] Subtest basic-rejected: SKIP (0.000s)
[62.336898] [007/133] (959s left) kms_cursor_edge_walk (128x128-right-edge)
[62.444449] Starting subtest: 128x128-right-edge
[62.446318] Starting dynamic subtest: pipe-A-eDP-1
[65.909188] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[65.918589] Starting dynamic subtest: pipe-D-eDP-1
[69.030306] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[69.032629] Subtest 128x128-right-edge: SUCCESS (6.587s)
[69.850174] [008/133] (951s left) api_intel_bb (reset-bb)
[69.911203] Starting subtest: reset-bb
[69.913332] Subtest reset-bb: SUCCESS (0.004s)
[70.066638] [009/133] (951s left) gem_exec_reloc (basic-gtt-read-active)
[70.129689] Subtest basic-gtt-read-active: SKIP (0.000s)
[70.198630] [010/133] (951s left) kms_psr (psr-no-drrs)
[70.295597] Starting subtest: psr-no-drrs
[70.297880] Starting dynamic subtest: eDP-1
[71.917947] Dynamic subtest eDP-1: SUCCESS (1.622s)
[71.920395] Subtest psr-no-drrs: SUCCESS (1.623s)
[72.822189] [011/133] (948s left) kms_chamelium_color (ctm-max)
[72.926062] Subtest ctm-max: SKIP (0.000s)
[72.966649] [012/133] (948s left) drm_mm (drm_mm)
[72.999703] Starting subtest: drm_mm
[73.012184] Starting dynamic subtest: drm_test_mm_init
[73.114207] Dynamic subtest drm_test_mm_init: SUCCESS (0.103s)
[73.122977] Starting dynamic subtest: drm_test_mm_debug
[73.272360] Dynamic subtest drm_test_mm_debug: SUCCESS (0.155s)
[73.281029] Starting dynamic subtest: drm_test_mm_align32
[73.415423] Dynamic subtest drm_test_mm_align32: SUCCESS (0.143s)
[73.424071] Starting dynamic subtest: drm_test_mm_align64
[73.557519] Dynamic subtest drm_test_mm_align64: SUCCESS (0.142s)
[73.566154] Starting dynamic subtest: drm_test_mm_lowest
[73.699478] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.141s)
[73.707943] Starting dynamic subtest: drm_test_mm_highest
[73.838276] Dynamic subtest drm_test_mm_highest: SUCCESS (0.139s)
[73.840650] Subtest drm_mm: SUCCESS (0.838s)
[74.048879] [013/133] (947s left) i915_query (query-topology-garbage-items)
[74.109873] Starting subtest: query-topology-garbage-items
[74.111835] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[74.235997] [014/133] (947s left) kms_hdr (bpc-switch)
[74.334864] Starting subtest: bpc-switch
[75.376891] Starting dynamic subtest: pipe-A-eDP-1
[78.871315] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[78.873688] Subtest bpc-switch: SUCCESS (4.539s)
[79.016822] [015/133] (942s left) kms_frontbuffer_tracking (psr-argb161616f-draw-pwrite)
[79.122523] Starting subtest: psr-argb161616f-draw-pwrite
[79.126627] Subtest psr-argb161616f-draw-pwrite: SKIP (0.000s)
[79.251132] [016/133] (942s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[84.293242] Starting subtest: fbc-pr-cursor-plane-update-sf
[84.297941] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s)
[85.187306] [017/133] (936s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[85.291012] Starting subtest: plane-upscale-20x20-with-rotation
[85.293284] Starting dynamic subtest: pipe-A
[85.515281] Dynamic subtest pipe-A: SUCCESS (0.227s)
[85.530693] Starting dynamic subtest: pipe-B
[86.840104] Dynamic subtest pipe-B: SUCCESS (1.325s)
[86.848267] Starting dynamic subtest: pipe-C
[88.166390] Dynamic subtest pipe-C: SUCCESS (1.325s)
[88.179052] Starting dynamic subtest: pipe-D
[89.497323] Dynamic subtest pipe-D: SUCCESS (1.331s)
[89.499665] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.210s)
[90.707813] [018/133] (931s left) gem_ccs (ctrl-surf-copy-new-ctx)
[90.784726] Starting subtest: ctrl-surf-copy-new-ctx
[90.788755] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[90.917914] [019/133] (931s left) gem_exec_alignment (single)
[90.989651] Starting subtest: single
[90.991859] Subtest single: SUCCESS (0.005s)
[91.159712] [020/133] (930s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[91.251617] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[91.253864] Starting dynamic subtest: pipe-A-default-mode
[92.445272] Dynamic subtest pipe-A-default-mode: SKIP (1.191s)
[92.449607] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.192s)
[92.623230] [021/133] (929s left) kms_lease (simple-lease)
[92.718225] Starting subtest: simple-lease
[92.720512] Starting dynamic subtest: pipe-A-eDP-1
[93.216835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.500s)
[93.226170] Starting dynamic subtest: pipe-B-eDP-1
[94.653855] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.434s)
[94.663135] Starting dynamic subtest: pipe-C-eDP-1
[96.048248] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[96.056789] Starting dynamic subtest: pipe-D-eDP-1
[97.451207] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.402s)
[97.453245] Subtest simple-lease: SUCCESS (4.733s)
[98.277484] [022/133] (923s left) perf (polling-parameterized)
[98.419885] Starting subtest: polling-parameterized
[118.441983] Subtest polling-parameterized: SUCCESS (20.021s)
[118.487066] [023/133] (903s left) perf_pmu (module-unload)
[118.567660] Starting subtest: module-unload
[126.945664] Subtest module-unload: FAIL (8.271s)
[126.978596] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[126.981504] [024/133] (895s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[128.510548] Starting subtest: basic-batch-kernel-default-cmd
[128.514709] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[128.678414] [FACT gem_exec_flush (basic-batch-kernel-default-cmd)] new: kernel.kmod_is_loaded.i915: true
[128.682089] [025/133] (893s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[128.784386] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[128.789145] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[129.945846] [026/133] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[130.047791] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[130.052169] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[130.177968] [027/133] (892s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[130.281997] Starting subtest: fbc-rgb101010-draw-render
[135.078199] Subtest fbc-rgb101010-draw-render: SUCCESS (4.808s)
[136.264779] [028/133] (886s left) gem_exec_reloc (basic-gtt)
[136.331475] Subtest basic-gtt: SKIP (0.000s)
[136.415928] [029/133] (886s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[136.518582] Starting subtest: 4-tiled-32bpp-rotate-270
[136.541360] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[136.687053] [030/133] (885s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[136.784622] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[136.786713] Starting dynamic subtest: pipe-A
[137.967550] Dynamic subtest pipe-A: SUCCESS (1.185s)
[137.975721] Starting dynamic subtest: pipe-B
[140.280751] Dynamic subtest pipe-B: SUCCESS (2.313s)
[140.289301] Starting dynamic subtest: pipe-C
[141.451746] Dynamic subtest pipe-C: SUCCESS (1.170s)
[141.461233] Starting dynamic subtest: pipe-D
[142.693075] Dynamic subtest pipe-D: SUCCESS (1.239s)
[142.695247] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.911s)
[143.887490] [031/133] (878s left) gem_ctx_shared (disjoint-timelines)
[143.968185] Starting subtest: disjoint-timelines
[144.004771] Subtest disjoint-timelines: SUCCESS (0.037s)
[144.272317] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[144.275969] [032/133] (878s left) kms_flip (wf_vblank-ts-check-interruptible)
[144.380756] Starting subtest: wf_vblank-ts-check-interruptible
[144.383075] Starting dynamic subtest: A-eDP1
[153.332994] Dynamic subtest A-eDP1: SUCCESS (8.949s)
[153.347647] Starting dynamic subtest: B-eDP1
[162.266847] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[162.277183] Starting dynamic subtest: C-eDP1
[171.195191] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[171.203804] Starting dynamic subtest: D-eDP1
[180.036943] Dynamic subtest D-eDP1: SUCCESS (8.839s)
[180.041843] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.656s)
[181.293068] [033/133] (841s left) kms_addfb_basic (bad-pitch-32)
[181.361648] Starting subtest: bad-pitch-32
[181.363922] Subtest bad-pitch-32: SUCCESS (0.000s)
[181.525207] [034/133] (841s left) gem_exec_fence (basic-busy)
[181.700268] Starting subtest: basic-busy
[181.702789] Starting dynamic subtest: rcs0
[181.810497] Dynamic subtest rcs0: SUCCESS (0.110s)
[181.821541] Starting dynamic subtest: bcs0
[181.874153] Dynamic subtest bcs0: SUCCESS (0.062s)
[181.884339] Starting dynamic subtest: vcs0
[181.936036] Dynamic subtest vcs0: SUCCESS (0.060s)
[181.946457] Starting dynamic subtest: vcs1
[181.997962] Dynamic subtest vcs1: SUCCESS (0.060s)
[182.007591] Starting dynamic subtest: vecs0
[182.057109] Dynamic subtest vecs0: SUCCESS (0.057s)
[182.066919] Starting dynamic subtest: ccs0
[182.121340] Dynamic subtest ccs0: SUCCESS (0.063s)
[182.123696] Subtest basic-busy: SUCCESS (0.422s)
[184.018997] [035/133] (838s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[184.137943] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[185.184080] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.045s)
[185.351794] [036/133] (837s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[185.463368] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[185.466818] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[185.584847] [037/133] (837s left) kms_pm_rpm (modeset-stress-extra-wait)
[187.119791] Starting subtest: modeset-stress-extra-wait
[241.405438] Subtest modeset-stress-extra-wait: SUCCESS (54.284s)
[241.524054] [038/133] (781s left) prime_vgem (basic-fence-mmap)
[241.612880] Starting subtest: basic-fence-mmap
[241.617980] Subtest basic-fence-mmap: SKIP (0.000s)
[241.758077] [039/133] (781s left) gem_userptr_blits (set-cache-level)
[241.834164] Starting subtest: set-cache-level
[241.838777] Subtest set-cache-level: SKIP (0.000s)
[242.010338] [040/133] (780s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[242.078846] Starting subtest: single-wait-for-submit-available-signaled
[242.081166] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[242.200932] [041/133] (780s left) gem_mmap_gtt (basic-small-copy-xy)
[242.263060] Subtest basic-small-copy-XY: SKIP (0.000s)
[242.338940] [042/133] (780s left) kms_flip (basic-flip-vs-wf_vblank)
[242.447330] Starting subtest: basic-flip-vs-wf_vblank
[242.449324] Starting dynamic subtest: A-eDP1
[244.406837] Dynamic subtest A-eDP1: SUCCESS (1.957s)
[244.424293] Starting dynamic subtest: B-eDP1
[246.341143] Dynamic subtest B-eDP1: SUCCESS (1.933s)
[246.352186] Starting dynamic subtest: C-eDP1
[248.261483] Dynamic subtest C-eDP1: SUCCESS (1.918s)
[248.272020] Starting dynamic subtest: D-eDP1
[250.194259] Dynamic subtest D-eDP1: SUCCESS (1.932s)
[250.199488] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.750s)
[251.444599] [043/133] (771s left) kms_getfb (getfb-handle-valid)
[251.548216] Starting subtest: getfb-handle-valid
[251.550566] Subtest getfb-handle-valid: SUCCESS (0.000s)
[251.692512] [044/133] (771s left) gen3_render_mixed_blits
[251.830146] [045/133] (771s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[252.224983] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[253.020190] [046/133] (770s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[253.122896] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[253.125066] Starting dynamic subtest: pipe-A-eDP-1
[253.417102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.265s)
[253.427009] Starting dynamic subtest: pipe-B-eDP-1
[254.738041] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.316s)
[254.746596] Starting dynamic subtest: pipe-C-eDP-1
[256.022517] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.285s)
[256.033064] Starting dynamic subtest: pipe-D-eDP-1
[257.247804] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[257.250129] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.094s)
[258.485057] [047/133] (764s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[258.539473] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[258.544208] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[258.745547] [048/133] (764s left) kms_cursor_crc (cursor-offscreen-32x32)
[258.893973] Starting subtest: cursor-offscreen-32x32
[258.942155] Subtest cursor-offscreen-32x32: SKIP (0.044s)
[259.241640] [049/133] (764s left) kms_psr (fbc-psr-basic)
[259.341716] Starting subtest: fbc-psr-basic
[259.344070] Starting dynamic subtest: eDP-1
[259.348377] Dynamic subtest eDP-1: SKIP (0.000s)
[259.352375] Subtest fbc-psr-basic: SKIP (0.003s)
[259.440880] [050/133] (763s left) kms_psr (fbc-psr2-cursor-blt)
[259.538093] Starting subtest: fbc-psr2-cursor-blt
[259.540256] Starting dynamic subtest: eDP-1
[259.544188] Dynamic subtest eDP-1: SKIP (0.000s)
[259.548207] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[259.633424] [051/133] (763s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[259.734222] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[259.736123] Starting dynamic subtest: pipe-A
[259.758980] Dynamic subtest pipe-A: SKIP (0.019s)
[259.768039] Starting dynamic subtest: pipe-B
[259.789951] Dynamic subtest pipe-B: SKIP (0.032s)
[259.798544] Starting dynamic subtest: pipe-C
[259.823226] Dynamic subtest pipe-C: SKIP (0.032s)
[259.831329] Starting dynamic subtest: pipe-D
[259.856441] Dynamic subtest pipe-D: SKIP (0.032s)
[259.859648] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.118s)
[259.980764] [052/133] (763s left) gem_exec_reloc (basic-write-gtt)
[260.046666] Subtest basic-write-gtt: SKIP (0.000s)
[260.119743] [053/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[260.207280] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[260.210978] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[260.345720] [054/133] (763s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[265.326040] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[265.328353] Starting dynamic subtest: pipe-A-eDP-1
[266.126272] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s)
[266.136352] Starting dynamic subtest: pipe-B-eDP-1
[267.253122] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[267.257573] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.927s)
[268.471359] [055/133] (755s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[268.572232] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[268.576709] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[269.705877] [056/133] (753s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[269.830038] Starting subtest: protected-encrypted-src-copy-not-readible
[269.941560] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[270.102762] [057/133] (753s left) syncobj_timeline (host-signal-points)
[270.172882] Starting subtest: host-signal-points
[270.178362] Subtest host-signal-points: SUCCESS (0.004s)
[270.307827] [058/133] (753s left) kms_flip (2x-flip-vs-expired-vblank)
[270.418604] Starting subtest: 2x-flip-vs-expired-vblank
[270.427191] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[270.575578] [059/133] (753s left) kms_pipe_stress (stress-xrgb8888-untiled)
[270.680451] Starting subtest: stress-xrgb8888-untiled
[276.577736] Subtest stress-xrgb8888-untiled: SUCCESS (5.898s)
[276.629510] [060/133] (747s left) kms_psr (psr2-primary-mmap-gtt)
[276.728464] Starting subtest: psr2-primary-mmap-gtt
[276.730282] Starting dynamic subtest: eDP-1
[278.170231] Dynamic subtest eDP-1: SKIP (1.438s)
[278.175215] Subtest psr2-primary-mmap-gtt: SKIP (1.440s)
[278.317880] [061/133] (745s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[278.375803] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[278.454562] [062/133] (745s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[278.515148] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[278.583345] [063/133] (745s left) gem_exec_reloc (basic-cpu-wc)
[278.651711] Subtest basic-cpu-wc: SKIP (0.000s)
[278.745194] [064/133] (745s left) gem_ctx_isolation (clean)
[278.816423] Starting subtest: clean
[278.818374] Starting dynamic subtest: rcs0
[278.864067] Dynamic subtest rcs0: SUCCESS (0.050s)
[278.873600] Starting dynamic subtest: bcs0
[278.954480] Dynamic subtest bcs0: SUCCESS (0.090s)
[278.963234] Starting dynamic subtest: vcs0
[279.037401] Dynamic subtest vcs0: SUCCESS (0.082s)
[279.048326] Starting dynamic subtest: vcs1
[280.923446] Dynamic subtest vcs1: SUCCESS (1.885s)
[280.932242] Starting dynamic subtest: vecs0
[282.947734] Dynamic subtest vecs0: SUCCESS (2.023s)
[282.956552] Starting dynamic subtest: ccs0
[284.947210] Dynamic subtest ccs0: SUCCESS (1.998s)
[284.949595] Subtest clean: SUCCESS (6.134s)
[285.222844] [065/133] (738s left) api_intel_allocator (simple-allocator)
[285.284376] Starting subtest: simple-allocator
[285.286666] Starting dynamic subtest: basic
[285.291449] Dynamic subtest basic: SUCCESS (0.008s)
[285.300036] Starting dynamic subtest: parallel-one
[285.467556] Dynamic subtest parallel-one: SUCCESS (0.174s)
[285.477784] Starting dynamic subtest: print
[285.480075] Dynamic subtest print: SUCCESS (0.000s)
[285.488592] Starting dynamic subtest: reuse
[285.490506] Dynamic subtest reuse: SUCCESS (0.000s)
[285.498499] Starting dynamic subtest: reserve
[285.500382] Dynamic subtest reserve: SUCCESS (0.000s)
[285.508616] Starting dynamic subtest: fork-reopen-allocator
[285.510628] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[285.512512] Subtest simple-allocator: SUCCESS (0.199s)
[285.645149] [066/133] (738s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[285.752327] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[286.853042] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.100s)
[287.019661] [067/133] (737s left) gem_exec_balancer (bonded-sync)
[287.082891] Starting subtest: bonded-sync
[287.086848] Subtest bonded-sync: SKIP (0.000s)
[287.405043] [068/133] (736s left) kms_content_protection (lic-type-0)
[287.557356] Starting subtest: lic-type-0
[287.562060] Subtest lic-type-0: SKIP (0.000s)
[287.726613] [069/133] (736s left) i915_drm_fdinfo (all-busy-idle-check-all)
[287.775100] Starting subtest: all-busy-idle-check-all
[287.779695] Subtest all-busy-idle-check-all: SKIP (0.003s)
[287.876214] [070/133] (736s left) kms_flip (2x-wf_vblank-ts-check)
[287.963118] Starting subtest: 2x-wf_vblank-ts-check
[287.975081] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[288.113586] [071/133] (736s left) kms_lease (lease-get)
[288.216328] Starting subtest: lease-get
[288.218626] Starting dynamic subtest: pipe-A-eDP-1
[288.220843] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[288.233218] Starting dynamic subtest: pipe-B-eDP-1
[288.235425] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[288.244051] Starting dynamic subtest: pipe-C-eDP-1
[288.246207] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[288.254614] Starting dynamic subtest: pipe-D-eDP-1
[288.256802] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[288.258998] Subtest lease-get: SUCCESS (0.009s)
[288.374646] [072/133] (735s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[288.487446] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[288.491179] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[288.624084] [073/133] (735s left) sw_sync (alloc_fence)
[288.663375] Starting subtest: alloc_fence
[288.664986] Subtest alloc_fence: SUCCESS (0.000s)
[288.747252] [074/133] (735s left) kms_force_connector_basic (force-edid)
[288.823940] Starting subtest: force-edid
[289.190583] Subtest force-edid: SUCCESS (0.369s)
[289.372399] [075/133] (735s left) kms_flip_scaled_crc (flip-32bpp-linear-to-32bpp-linear-reflect-x)
[289.478495] Starting subtest: flip-32bpp-linear-to-32bpp-linear-reflect-x
[289.480505] Starting dynamic subtest: pipe-A-default-mode
[290.654613] Dynamic subtest pipe-A-default-mode: SKIP (1.173s)
[290.659198] Subtest flip-32bpp-linear-to-32bpp-linear-reflect-x: SKIP (1.176s)
[290.850406] [076/133] (733s left) gem_ppgtt (blt-vs-render-ctx0)
[290.914704] Starting subtest: blt-vs-render-ctx0
[324.120695] Subtest blt-vs-render-ctx0: SUCCESS (33.204s)
[324.283456] [077/133] (700s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[324.420460] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[324.422741] Starting dynamic subtest: pipe-A-default-mode
[324.727079] Dynamic subtest pipe-A-default-mode: SKIP (0.305s)
[324.731713] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.307s)
[325.553257] [078/133] (698s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[325.624687] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[325.627187] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[325.734101] [079/133] (698s left) syncobj_timeline (wait-all-snapshot)
[325.794495] Starting subtest: wait-all-snapshot
[325.874239] Subtest wait-all-snapshot: SUCCESS (0.081s)
[325.979877] [080/133] (698s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[326.050070] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[326.154843] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[326.257761] [081/133] (698s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[326.354178] Starting subtest: fbc-psr-sprite-mmap-cpu
[326.356430] Starting dynamic subtest: eDP-1
[326.360519] Dynamic subtest eDP-1: SKIP (0.000s)
[326.364677] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[326.448928] [082/133] (698s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[326.550216] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[327.364597] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.816s)
[327.551213] [083/133] (697s left) kms_async_flips (invalid-async-flip-atomic)
[327.658061] Starting subtest: invalid-async-flip-atomic
[328.033741] Starting dynamic subtest: pipe-A-eDP-1
[328.816407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.782s)
[329.175143] Starting dynamic subtest: pipe-B-eDP-1
[330.013275] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.847s)
[330.367944] Starting dynamic subtest: pipe-C-eDP-1
[331.205240] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.845s)
[331.558062] Starting dynamic subtest: pipe-D-eDP-1
[332.403099] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.853s)
[332.405389] Subtest invalid-async-flip-atomic: SUCCESS (4.747s)
[333.648699] [084/133] (691s left) gem_exec_params (dr1-dirt)
[333.719345] Starting subtest: DR1-dirt
[333.721312] Subtest DR1-dirt: SUCCESS (0.000s)
[333.847494] [085/133] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[333.946398] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[333.950425] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[334.075585] [086/133] (690s left) kms_cursor_legacy (forked-bo)
[334.204787] Starting subtest: forked-bo
[334.207146] Starting dynamic subtest: pipe-A
[339.661694] Dynamic subtest pipe-A: SUCCESS (5.455s)
[339.674529] Starting dynamic subtest: pipe-B
[345.134965] Dynamic subtest pipe-B: SUCCESS (5.471s)
[345.146550] Starting dynamic subtest: pipe-C
[350.614346] Dynamic subtest pipe-C: SUCCESS (5.477s)
[350.629449] Starting dynamic subtest: pipe-D
[356.089065] Dynamic subtest pipe-D: SUCCESS (5.472s)
[356.100923] Starting dynamic subtest: all-pipes
[361.614211] Dynamic subtest all-pipes: SUCCESS (5.522s)
[361.616767] Subtest forked-bo: SUCCESS (27.408s)
[361.780723] [087/133] (663s left) kms_vblank (wait-forked-hang)
[361.882419] Starting subtest: wait-forked-hang
[361.884720] Starting dynamic subtest: pipe-A-eDP-1
[388.694814] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.813s)
[388.708723] Starting dynamic subtest: pipe-D-eDP-1
[413.658199] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.960s)
[413.660683] Subtest wait-forked-hang: SUCCESS (51.777s)
[414.545288] [088/133] (610s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[414.647969] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[414.652405] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[414.794064] [089/133] (610s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[414.853830] Subtest untiled-to-tiled: SKIP (0.000s)
[414.918266] [090/133] (610s left) kms_frontbuffer_tracking (fbc-argb161616f-draw-mmap-gtt)
[415.018670] Starting subtest: fbc-argb161616f-draw-mmap-gtt
[415.023180] Subtest fbc-argb161616f-draw-mmap-gtt: SKIP (0.000s)
[415.157571] [091/133] (609s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[415.269451] Starting subtest: psr-rgb101010-draw-render
[422.604217] Subtest psr-rgb101010-draw-render: SUCCESS (7.338s)
[422.775115] [092/133] (602s left) fbdev (info)
[422.821299] Starting subtest: info
[422.823121] Subtest info: SUCCESS (0.000s)
[422.915538] [093/133] (602s left) kms_flip (plain-flip-interruptible)
[423.016307] Starting subtest: plain-flip-interruptible
[423.018537] Starting dynamic subtest: A-eDP1
[424.691900] Dynamic subtest A-eDP1: SUCCESS (1.674s)
[424.703613] Starting dynamic subtest: B-eDP1
[426.389795] Dynamic subtest B-eDP1: SUCCESS (1.696s)
[426.400860] Starting dynamic subtest: C-eDP1
[428.078535] Dynamic subtest C-eDP1: SUCCESS (1.686s)
[428.096649] Starting dynamic subtest: D-eDP1
[429.768641] Dynamic subtest D-eDP1: SUCCESS (1.687s)
[429.771055] Subtest plain-flip-interruptible: SUCCESS (6.755s)
[431.039742] [094/133] (594s left) gem_tiled_wc
[431.184789] [095/133] (594s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[436.317221] Starting subtest: pr-primary-plane-update-sf-dmg-area
[436.321638] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[437.131807] [096/133] (588s left) kms_flip (2x-flip-vs-wf_vblank)
[437.233216] Starting subtest: 2x-flip-vs-wf_vblank
[437.245576] Subtest 2x-flip-vs-wf_vblank: SKIP (0.012s)
[437.368265] [097/133] (587s left) kms_async_flips (async-flip-suspend-resume)
[437.458841] Starting subtest: async-flip-suspend-resume
[437.830987] Starting dynamic subtest: pipe-A-eDP-1
[455.471917] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.000s)
[455.849516] Starting dynamic subtest: pipe-B-eDP-1
[473.490873] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.915s)
[473.849973] Starting dynamic subtest: pipe-C-eDP-1
[491.500291] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.967s)
[491.865482] Starting dynamic subtest: pipe-D-eDP-1
[509.491108] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.917s)
[509.493436] Subtest async-flip-suspend-resume: SUCCESS (13.261s)
[510.735970] [098/133] (514s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[510.846033] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[510.850216] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[510.988574] [099/133] (514s left) gem_exec_whisper (basic-contexts-priority)
[511.063384] Starting subtest: basic-contexts-priority
[534.489423] Subtest basic-contexts-priority: SUCCESS (23.407s)
[534.701644] [100/133] (490s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[534.827216] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[534.831721] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[534.967992] [101/133] (490s left) gem_exec_schedule (noreorder)
[535.164952] Starting subtest: noreorder
[535.166965] Starting dynamic subtest: rcs0
[535.243988] Dynamic subtest rcs0: SUCCESS (0.082s)
[535.257643] Starting dynamic subtest: vcs0
[536.697686] Dynamic subtest vcs0: SUCCESS (1.449s)
[536.711451] Starting dynamic subtest: vcs1
[538.641178] Dynamic subtest vcs1: SUCCESS (1.939s)
[538.654639] Starting dynamic subtest: vecs0
[540.668749] Dynamic subtest vecs0: SUCCESS (2.024s)
[540.681911] Starting dynamic subtest: ccs0
[540.757431] Dynamic subtest ccs0: SUCCESS (0.087s)
[540.760153] Subtest noreorder: SUCCESS (5.594s)
[540.968776] [102/133] (484s left) kms_addfb_basic (tile-pitch-mismatch)
[541.038567] Starting subtest: tile-pitch-mismatch
[541.043413] Subtest tile-pitch-mismatch: SKIP (0.000s)
[541.209204] [103/133] (484s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[541.308254] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[541.312530] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[541.444612] [104/133] (484s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[541.545202] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[541.549535] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[541.675576] [105/133] (484s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[541.742747] Starting subtest: saturated-hostile-nopreempt
[541.745133] Starting dynamic subtest: rcs0
[541.837249] Dynamic subtest rcs0: SKIP (0.092s)
[541.850588] Starting dynamic subtest: bcs0
[541.864099] Dynamic subtest bcs0: SKIP (0.025s)
[541.874786] Starting dynamic subtest: vcs0
[541.883863] Dynamic subtest vcs0: SKIP (0.018s)
[541.894194] Starting dynamic subtest: vcs1
[541.908268] Dynamic subtest vcs1: SKIP (0.023s)
[541.918514] Starting dynamic subtest: vecs0
[541.924260] Dynamic subtest vecs0: SKIP (0.014s)
[541.934525] Starting dynamic subtest: ccs0
[541.946278] Dynamic subtest ccs0: SKIP (0.021s)
[541.949868] Subtest saturated-hostile-nopreempt: SKIP (0.203s)
[542.047160] [106/133] (483s left) kms_hdmi_inject (inject-4k)
[542.388860] Starting subtest: inject-4k
[542.704401] Subtest inject-4k: SUCCESS (0.317s)
[543.289428] [107/133] (482s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[543.386349] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[543.390730] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[543.531781] [108/133] (482s left) syncobj_basic (illegal-fd-to-handle)
[543.597875] Starting subtest: illegal-fd-to-handle
[543.599802] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[543.733136] [109/133] (482s left) gem_exec_reloc (basic-active)
[543.804034] Subtest basic-active: SKIP (0.000s)
[543.896180] [110/133] (482s left) kms_color (invalid-ctm-matrix-sizes)
[543.990085] Starting subtest: invalid-ctm-matrix-sizes
[543.992457] Starting dynamic subtest: pipe-A
[543.994758] Dynamic subtest pipe-A: SUCCESS (0.002s)
[544.006225] Starting dynamic subtest: pipe-B
[544.008485] Dynamic subtest pipe-B: SUCCESS (0.003s)
[544.019179] Starting dynamic subtest: pipe-C
[544.021151] Dynamic subtest pipe-C: SUCCESS (0.004s)
[544.031716] Starting dynamic subtest: pipe-D
[544.033942] Dynamic subtest pipe-D: SUCCESS (0.004s)
[544.036183] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[544.099333] [111/133] (481s left) gem_mmap_gtt (cpuset-big-copy-odd)
[544.167784] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[544.230348] [112/133] (481s left) kms_vblank (query-forked-hang)
[544.331063] Starting subtest: query-forked-hang
[544.332918] Starting dynamic subtest: pipe-A-eDP-1
[570.403880] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.060s)
[570.420572] Starting dynamic subtest: pipe-D-eDP-1
[585.449853] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.035s)
[585.452278] Subtest query-forked-hang: SUCCESS (41.100s)
[586.274618] [113/133] (439s left) gem_softpin (reverse)
[586.332403] Starting subtest: reverse
[586.337448] Subtest reverse: SUCCESS (0.005s)
[586.489781] [114/133] (439s left) i915_pm_rps (engine-order)
[586.554778] Starting subtest: engine-order
[591.385439] Subtest engine-order: SUCCESS (4.825s)
[591.550484] [115/133] (434s left) gem_mmap_gtt (basic-read-write)
[591.610868] Subtest basic-read-write: SKIP (0.000s)
[591.672542] [116/133] (434s left) gem_ppgtt (shrink-vs-evict-any)
[591.738970] Starting subtest: shrink-vs-evict-any
[597.632909] Subtest shrink-vs-evict-any: SUCCESS (5.888s)
[597.749504] [117/133] (428s left) gem_exec_fence (submit3)
[597.944263] Starting subtest: submit3
[597.949805] Subtest submit3: SKIP (0.000s)
[599.730014] [118/133] (426s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[599.915472] Starting subtest: cursor-rapid-movement-32x10
[599.965165] Subtest cursor-rapid-movement-32x10: SKIP (0.045s)
[600.267813] [119/133] (426s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[600.364653] Starting subtest: bad-rotation-90-y-tiled-ccs
[600.366959] Starting dynamic subtest: pipe-A-eDP-1
[600.389986] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[600.402874] Starting dynamic subtest: pipe-B-eDP-1
[600.424579] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[600.434921] Starting dynamic subtest: pipe-C-eDP-1
[600.456569] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[600.467303] Starting dynamic subtest: pipe-D-eDP-1
[600.490556] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[600.495166] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[602.676159] [120/133] (423s left) gem_exec_whisper (basic-queues-priority-all)
[602.750830] Starting subtest: basic-queues-priority-all
[622.930677] Subtest basic-queues-priority-all: SUCCESS (20.171s)
[623.143923] [121/133] (403s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[623.245096] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[623.249176] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[623.383203] [122/133] (403s left) syncobj_eventfd (timeline-wait-signaled)
[623.454516] Starting subtest: timeline-wait-signaled
[623.456930] Subtest timeline-wait-signaled: SUCCESS (0.001s)
[623.590989] [123/133] (402s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[623.688954] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[631.149350] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.457s)
[631.320254] [124/133] (395s left) gem_exec_params (invalid-ring2)
[631.382209] Starting subtest: invalid-ring2
[631.384432] Subtest invalid-ring2: SUCCESS (0.000s)
[631.526208] [125/133] (395s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[631.620691] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[631.624982] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[631.745667] [126/133] (394s left) kms_feature_discovery (chamelium)
[631.847118] Starting subtest: chamelium
[631.852033] Subtest chamelium: SKIP (0.000s)
[631.944587] [127/133] (394s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[632.038777] Starting subtest: primary-y-tiled-reflect-x-90
[632.043084] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[632.139652] [128/133] (394s left) i915_pm_freq_api (freq-reset)
[632.210700] Starting subtest: freq-reset
[632.212794] Starting dynamic subtest: gt0
[632.402264] Dynamic subtest gt0: SUCCESS (0.188s)
[632.412726] Starting dynamic subtest: gt1
[632.568848] Dynamic subtest gt1: SUCCESS (0.166s)
[632.571575] Subtest freq-reset: SUCCESS (0.356s)
[632.674756] [129/133] (394s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[632.786003] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[632.790129] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[632.920067] [130/133] (393s left) kms_chamelium_edid (dp-edid-read)
[633.306316] Subtest dp-edid-read: SKIP (0.000s)
[634.154008] [131/133] (392s left) kms_universal_plane (cursor-fb-leak)
[634.251309] Starting subtest: cursor-fb-leak
[634.253611] Starting dynamic subtest: pipe-A-eDP-1
[634.583080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.333s)
[634.600993] Starting dynamic subtest: pipe-B-eDP-1
[635.933174] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.346s)
[635.946668] Starting dynamic subtest: pipe-C-eDP-1
[637.309847] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[637.322238] Starting dynamic subtest: pipe-D-eDP-1
[638.616649] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[638.619017] Subtest cursor-fb-leak: SUCCESS (4.364s)
[639.787252] [132/133] (387s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[639.890534] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[639.895031] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[640.013567] [133/133] (386s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[640.105580] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[640.109535] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[640.242681] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gen7_exec_parse
results: parsing output: 6/ for test: kms_cursor_edge_walk
results: parsing output: 7/ for test: api_intel_bb
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_chamelium_color
results: parsing output: 11/ for test: drm_mm
results: parsing output: 12/ for test: i915_query
results: parsing output: 13/ for test: kms_hdr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: gem_ccs
results: parsing output: 18/ for test: gem_exec_alignment
results: parsing output: 19/ for test: kms_flip_scaled_crc
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: gem_exec_flush
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: gem_ctx_shared
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: prime_vgem
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_getfb
results: parsing output: 43/ for test: gen3_render_mixed_blits
results: parsing output: 44/ for test: kms_chamelium_hpd
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_pipe_stress
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_fenced_exec_thrash
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_content_protection
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_force_connector_basic
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: gem_ppgtt
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_async_flips
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_set_tiling_vs_blt
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: fbdev
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: gem_tiled_wc
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_hdmi_inject
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_color
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: i915_pm_rps
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: gem_ppgtt
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_eventfd
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_feature_discovery
results: parsing output: 126/ for test: kms_rotation_crc
results: parsing output: 127/ for test: i915_pm_freq_api
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_chamelium_edid
results: parsing output: 130/ for test: kms_universal_plane
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.