[57.137848] Initializing watchdogs
[57.137955]   /dev/watchdog0
[57.153380] [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]
[57.158055] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.160274] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.163815] [001/133] (960s left) gem_userptr_blits (sync-unmap)
[57.253774] Starting subtest: sync-unmap
[57.271693] Subtest sync-unmap: SUCCESS (0.020s)
[57.379531] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[57.484300] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[57.488618] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[57.590988] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[57.692606] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[57.697311] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[57.794987] [004/133] (959s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[57.897181] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[58.918592] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.013s)
[59.091003] [005/133] (958s left) vgem_basic (busy-fence)
[59.165916] Starting subtest: busy-fence
[59.167808] Subtest busy-fence: SUCCESS (0.000s)
[59.215729] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[59.218421] [006/133] (958s left) kms_fence_pin_leak
[59.380407] [007/133] (958s left) gem_exec_reloc (basic-cpu-wc)
[59.441519] Subtest basic-cpu-wc: SKIP (0.000s)
[59.516343] [008/133] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[59.615437] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[67.425335] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.774s)
[67.628785] [009/133] (950s left) gem_exec_fence (syncobj-timeline-signal)
[68.180468] Starting subtest: syncobj-timeline-signal
[68.185070] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[69.978207] [010/133] (948s left) gem_exec_basic (basic)
[70.033765] Starting subtest: basic
[70.035916] Starting dynamic subtest: rcs0-smem
[70.038401] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[70.048505] Starting dynamic subtest: bcs0-smem
[70.050766] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[70.057962] Starting dynamic subtest: vcs0-smem
[70.060172] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[70.067336] Starting dynamic subtest: vcs1-smem
[70.069239] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[70.076061] Starting dynamic subtest: vecs0-smem
[70.077879] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[70.084743] Starting dynamic subtest: ccs0-smem
[70.086672] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[70.088588] Subtest basic: SUCCESS (0.013s)
[71.935453] [011/133] (946s left) kms_flip (dpms-vs-vblank-race-interruptible)
[72.040623] Starting subtest: dpms-vs-vblank-race-interruptible
[72.043065] Starting dynamic subtest: A-eDP1
[76.944995] Dynamic subtest A-eDP1: SUCCESS (4.896s)
[76.952552] Starting dynamic subtest: B-eDP1
[81.561268] Dynamic subtest B-eDP1: SUCCESS (4.611s)
[81.571796] Starting dynamic subtest: C-eDP1
[86.169891] Dynamic subtest C-eDP1: SUCCESS (4.604s)
[86.177526] Starting dynamic subtest: D-eDP1
[90.779053] Dynamic subtest D-eDP1: SUCCESS (4.606s)
[90.783925] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.727s)
[91.657023] [012/133] (926s left) gem_exec_schedule (pi-userfault)
[91.854509] Starting subtest: pi-userfault
[91.856499] Starting dynamic subtest: rcs0
[91.863293] Dynamic subtest rcs0: SUCCESS (0.012s)
[91.871432] Starting dynamic subtest: bcs0
[91.873809] Dynamic subtest bcs0: SUCCESS (0.009s)
[91.881302] Starting dynamic subtest: vcs0
[91.883622] Dynamic subtest vcs0: SUCCESS (0.008s)
[91.891270] Starting dynamic subtest: vcs1
[91.893576] Dynamic subtest vcs1: SUCCESS (0.008s)
[91.900625] Starting dynamic subtest: vecs0
[91.903048] Dynamic subtest vecs0: SUCCESS (0.012s)
[91.909819] Starting dynamic subtest: ccs0
[91.912266] Dynamic subtest ccs0: SUCCESS (0.007s)
[91.914568] Subtest pi-userfault: SUCCESS (0.059s)
[92.095876] [013/133] (926s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[92.194184] Starting subtest: yf-tiled-64bpp-rotate-180
[92.198381] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[92.310634] [014/133] (925s left) core_auth (many-magics)
[92.376752] Starting subtest: many-magics
[93.141420] Subtest many-magics: SUCCESS (0.767s)
[93.341198] [015/133] (924s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[93.437450] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[93.439291] Starting dynamic subtest: pipe-A-eDP-1
[93.586124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[93.595395] Starting dynamic subtest: pipe-B-eDP-1
[93.611581] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[93.620092] Starting dynamic subtest: pipe-C-eDP-1
[93.636942] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[93.644935] Starting dynamic subtest: pipe-D-eDP-1
[93.660865] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[93.662492] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.174s)
[95.920680] [016/133] (922s left) gem_mmap_wc (write-read)
[95.981571] Subtest write-read: SKIP (0.000s)
[96.035453] [017/133] (922s left) kms_cursor_crc (cursor-onscreen-512x512)
[96.289869] Starting subtest: cursor-onscreen-512x512
[96.294358] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[96.442163] [018/133] (921s left) kms_chamelium_frames (vga-frame-dump)
[96.839286] Subtest vga-frame-dump: SKIP (0.000s)
[97.632552] [019/133] (920s left) kms_plane_scaling (invalid-num-scalers)
[97.728200] Starting subtest: invalid-num-scalers
[97.730597] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[97.744506] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[97.757773] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[97.778253] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[97.786546] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[97.807715] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[97.815309] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[97.838814] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[97.841144] Subtest invalid-num-scalers: SUCCESS (0.113s)
[97.955808] [020/133] (920s left) gem_exec_reloc (basic-write-wc-active)
[98.017929] Subtest basic-write-wc-active: SKIP (0.000s)
[98.086905] [021/133] (920s left) perf_pmu (init-busy)
[98.127882] Starting subtest: init-busy
[98.130296] Starting dynamic subtest: rcs0
[98.132567] Dynamic subtest rcs0: SUCCESS (0.001s)
[98.140425] Starting dynamic subtest: bcs0
[98.142612] Dynamic subtest bcs0: SUCCESS (0.000s)
[98.149742] Starting dynamic subtest: vcs0
[98.152136] Dynamic subtest vcs0: SUCCESS (0.000s)
[98.159304] Starting dynamic subtest: vcs1
[98.161606] Dynamic subtest vcs1: SUCCESS (0.001s)
[98.168340] Starting dynamic subtest: vecs0
[98.170271] Dynamic subtest vecs0: SUCCESS (0.001s)
[98.177060] Starting dynamic subtest: ccs0
[98.178942] Dynamic subtest ccs0: SUCCESS (0.000s)
[98.180890] Subtest init-busy: SUCCESS (0.005s)
[98.262117] [022/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[98.361597] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[98.365713] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[98.466837] [023/133] (920s left) gem_lmem_swapping (heavy-verify-random)
[98.514868] Subtest heavy-verify-random: SKIP (0.000s)
[98.559919] [024/133] (920s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[98.651630] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[98.655473] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[99.787851] [025/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[99.895682] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[99.900181] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[99.998626] [026/133] (918s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[100.054804] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[100.057089] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[100.176069] [027/133] (918s left) kms_content_protection (type1)
[100.321102] Starting subtest: type1
[100.325608] Subtest type1: SKIP (0.000s)
[100.445499] [028/133] (918s left) prime_vgem (fence-wait)
[100.510732] Starting subtest: fence-wait
[100.512842] Starting dynamic subtest: rcs0
[101.551168] Dynamic subtest rcs0: SUCCESS (1.039s)
[101.564650] Starting dynamic subtest: bcs0
[102.615884] Dynamic subtest bcs0: SUCCESS (1.063s)
[102.626095] Starting dynamic subtest: vcs0
[103.656516] Dynamic subtest vcs0: SUCCESS (1.039s)
[103.666953] Starting dynamic subtest: vcs1
[104.702232] Dynamic subtest vcs1: SUCCESS (1.043s)
[104.712948] Starting dynamic subtest: vecs0
[105.744338] Dynamic subtest vecs0: SUCCESS (1.040s)
[105.754591] Starting dynamic subtest: ccs0
[106.793556] Dynamic subtest ccs0: SUCCESS (1.047s)
[106.796352] Subtest fence-wait: SUCCESS (6.281s)
[106.921238] [029/133] (911s left) syncobj_timeline (invalid-signal-zero-handles)
[106.982075] Starting subtest: invalid-signal-zero-handles
[106.984355] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[107.071941] [030/133] (911s left) gem_mmap_wc (coherency)
[107.127871] Subtest coherency: SKIP (0.000s)
[107.190784] [031/133] (911s left) gem_mmap_gtt (basic-short)
[107.251498] Subtest basic-short: SKIP (0.000s)
[107.311048] [032/133] (911s left) perf (per-context-mode-unprivileged)
[107.438760] Starting subtest: per-context-mode-unprivileged
[107.443205] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[107.480709] [033/133] (911s left) kms_chamelium_audio (dp-audio-edid)
[107.870912] Subtest dp-audio-edid: SKIP (0.000s)
[108.701345] [034/133] (910s left) gen9_exec_parse (cmd-crossing-page)
[108.770834] Subtest cmd-crossing-page: SKIP (0.000s)
[108.838304] [035/133] (910s left) gem_spin_batch (user-each)
[108.910673] Starting subtest: user-each
[112.184066] Subtest user-each: SUCCESS (3.264s)
[113.956231] [036/133] (905s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[114.060083] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[114.062456] Starting dynamic subtest: pipe-A-default-mode
[116.760989] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[116.763343] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.701s)
[117.635953] [037/133] (901s left) gem_userptr_blits (create-destroy-unsync)
[117.711790] Subtest create-destroy-unsync: SKIP (0.000s)
[117.839863] [038/133] (901s left) kms_cursor_crc (cursor-sliding-512x512)
[118.104774] Starting subtest: cursor-sliding-512x512
[118.109217] Subtest cursor-sliding-512x512: SKIP (0.001s)
[118.260059] [039/133] (900s left) gem_ctx_persistence (heartbeat-many)
[118.326660] Starting subtest: heartbeat-many
[118.331357] Subtest heartbeat-many: SKIP (0.000s)
[118.434967] [040/133] (900s left) gem_exec_whisper (basic-forked-all)
[118.510076] Starting subtest: basic-forked-all
[131.865334] Subtest basic-forked-all: SUCCESS (13.349s)
[132.051563] [041/133] (887s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[132.158073] Starting subtest: fbcpsr-tiling-4
[139.099948] Subtest fbcpsr-tiling-4: SUCCESS (6.944s)
[139.220962] [042/133] (880s left) kms_psr (fbc-psr2-sprite-plane-move)
[139.313082] Starting subtest: fbc-psr2-sprite-plane-move
[139.315308] Starting dynamic subtest: eDP-1
[139.319245] Dynamic subtest eDP-1: SKIP (0.000s)
[139.323253] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[139.390695] [043/133] (879s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[139.483170] Starting subtest: fb-8bpc-vs-panel-6bpc
[139.485494] Starting dynamic subtest: pipe-A-eDP-1
[140.868750] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.386s)
[140.871066] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.388s)
[141.719499] [044/133] (877s left) kms_vblank (query-idle-hang)
[141.809109] Starting subtest: query-idle-hang
[141.810965] Starting dynamic subtest: pipe-A-eDP-1
[169.684421] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.876s)
[169.698701] Starting dynamic subtest: pipe-D-eDP-1
[184.735045] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.044s)
[184.737623] Subtest query-idle-hang: SUCCESS (42.927s)
[185.577327] [045/133] (833s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[185.679374] Starting subtest: async-flip-with-page-flip-events-linear
[186.050631] Starting dynamic subtest: pipe-A-eDP-1
[188.889527] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.784s)
[189.199031] Starting dynamic subtest: pipe-B-eDP-1
[192.022247] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.776s)
[192.334141] Starting dynamic subtest: pipe-C-eDP-1
[195.151579] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s)
[195.460838] Starting dynamic subtest: pipe-D-eDP-1
[198.281671] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[198.283893] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.551s)
[199.414400] [046/133] (820s left) sw_sync (alloc_fence_invalid_timeline)
[199.451815] Starting subtest: alloc_fence_invalid_timeline
[199.454054] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[199.515010] [047/133] (820s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[199.615929] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[199.618056] Starting dynamic subtest: pipe-A-default-mode
[202.330079] Dynamic subtest pipe-A-default-mode: SUCCESS (2.715s)
[202.332530] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.716s)
[203.212839] [048/133] (816s left) kms_flip (2x-flip-vs-wf_vblank)
[203.309197] Starting subtest: 2x-flip-vs-wf_vblank
[203.317689] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[203.425962] [049/133] (816s left) kms_flip (2x-nonexisting-fb)
[203.527253] Starting subtest: 2x-nonexisting-fb
[203.543417] Subtest 2x-nonexisting-fb: SKIP (0.015s)
[203.627120] [050/133] (816s left) gem_exec_schedule (promotion)
[203.692429] Starting subtest: promotion
[203.694420] Starting dynamic subtest: rcs0
[203.794195] Dynamic subtest rcs0: SUCCESS (0.110s)
[203.805212] Starting dynamic subtest: vcs0
[203.878908] Dynamic subtest vcs0: SUCCESS (0.084s)
[203.889959] Starting dynamic subtest: vcs1
[203.955613] Dynamic subtest vcs1: SUCCESS (0.076s)
[203.966763] Starting dynamic subtest: vecs0
[204.033929] Dynamic subtest vecs0: SUCCESS (0.078s)
[204.044235] Starting dynamic subtest: ccs0
[204.121477] Dynamic subtest ccs0: SUCCESS (0.085s)
[204.123856] Subtest promotion: SUCCESS (0.436s)
[204.986382] [051/133] (814s left) kms_cursor_crc (cursor-random-max-size)
[205.279105] Starting subtest: cursor-random-max-size
[205.285383] Subtest cursor-random-max-size: SKIP (0.000s)
[205.411678] [052/133] (814s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[205.529080] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[212.905572] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.380s)
[213.065455] [053/133] (806s left) kms_flip (flip-vs-blocking-wf-vblank)
[213.166813] Starting subtest: flip-vs-blocking-wf-vblank
[213.169224] Starting dynamic subtest: A-eDP1
[222.089382] Dynamic subtest A-eDP1: SUCCESS (8.925s)
[222.097098] Starting dynamic subtest: B-eDP1
[231.008657] Dynamic subtest B-eDP1: SUCCESS (8.917s)
[231.022340] Starting dynamic subtest: C-eDP1
[239.980520] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[239.991483] Starting dynamic subtest: D-eDP1
[248.915371] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[248.917717] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.706s)
[250.097395] [054/133] (769s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[250.194132] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[250.196490] Starting dynamic subtest: pipe-A-eDP-1
[266.648656] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.460s)
[266.656679] Starting dynamic subtest: pipe-B-eDP-1
[283.864899] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.215s)
[283.867299] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.678s)
[284.757987] [055/133] (735s left) i915_drm_fdinfo (most-busy-check-all)
[284.795736] Starting subtest: most-busy-check-all
[284.798204] Starting dynamic subtest: rcs0
[284.802940] Dynamic subtest rcs0: SKIP (0.003s)
[284.811806] Starting dynamic subtest: bcs0
[284.815690] Dynamic subtest bcs0: SKIP (0.000s)
[284.826425] Starting dynamic subtest: vcs0
[284.830807] Dynamic subtest vcs0: SKIP (0.000s)
[284.839950] Starting dynamic subtest: vcs1
[284.844044] Dynamic subtest vcs1: SKIP (0.000s)
[284.851956] Starting dynamic subtest: vecs0
[284.855897] Dynamic subtest vecs0: SKIP (0.000s)
[284.863181] Starting dynamic subtest: ccs0
[284.867173] Dynamic subtest ccs0: SKIP (0.000s)
[284.871086] Subtest most-busy-check-all: SKIP (0.009s)
[284.907324] [056/133] (734s left) gem_pxp (verify-pxp-stale-buf-execution)
[285.033532] Starting subtest: verify-pxp-stale-buf-execution
[286.094940] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[286.216507] [057/133] (733s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[286.275741] Starting subtest: y-tiled-ccs-to-yf-tiled
[286.280553] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[286.472794] [058/133] (733s left) i915_pm_rpm (gem-idle)
[288.004084] Starting subtest: gem-idle
[294.219887] Subtest gem-idle: SUCCESS (6.197s)
[294.552199] [059/133] (725s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[295.872049] Starting subtest: y-tiled-ccs-to-y-tiled
[295.876320] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[296.063480] [060/133] (724s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[296.164152] Starting subtest: fbc-psr2-cursor-mmap-gtt
[296.166330] Starting dynamic subtest: eDP-1
[296.170274] Dynamic subtest eDP-1: SKIP (0.000s)
[296.174217] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[296.238531] [061/133] (723s left) kms_color_pipeline (plane-ctm3x4)
[296.332814] Starting subtest: plane-ctm3x4
[296.500413] Starting dynamic subtest: pipe-A-plane-0
[296.668493] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[296.680019] Starting dynamic subtest: pipe-A-plane-1
[296.822984] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[296.831799] Starting dynamic subtest: pipe-A-plane-2
[296.934103] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s)
[298.119255] Starting dynamic subtest: pipe-B-plane-0
[298.234054] Dynamic subtest pipe-B-plane-0: SUCCESS (0.122s)
[298.243256] Starting dynamic subtest: pipe-B-plane-1
[298.345574] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[298.354762] Starting dynamic subtest: pipe-B-plane-2
[298.467136] Dynamic subtest pipe-B-plane-2: SUCCESS (0.121s)
[299.648594] Starting dynamic subtest: pipe-C-plane-0
[299.750528] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[299.759296] Starting dynamic subtest: pipe-C-plane-1
[299.884305] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[299.901595] Starting dynamic subtest: pipe-C-plane-2
[300.006178] Dynamic subtest pipe-C-plane-2: SUCCESS (0.119s)
[301.176963] Starting dynamic subtest: pipe-D-plane-0
[301.303365] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[301.312622] Starting dynamic subtest: pipe-D-plane-1
[301.447941] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[301.456887] Starting dynamic subtest: pipe-D-plane-2
[301.569901] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s)
[301.856822] Subtest plane-ctm3x4: SUCCESS (5.526s)
[302.654223] [062/133] (717s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[302.761034] Starting subtest: x-tiled-8bpp-rotate-180
[303.929765] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.169s)
[304.038276] [063/133] (716s left) perf_pmu (invalid-init)
[304.078175] Starting subtest: invalid-init
[304.080426] Subtest invalid-init: SUCCESS (0.000s)
[304.205514] [064/133] (716s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[304.301134] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[304.304568] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[304.395455] [065/133] (715s left) gem_reg_read (bad-register)
[304.450688] Starting subtest: bad-register
[304.452325] Subtest bad-register: SUCCESS (0.000s)
[304.569675] [066/133] (715s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[304.655084] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[304.658492] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[304.743835] [067/133] (715s left) gem_ccs (suspend-resume)
[304.813526] Starting subtest: suspend-resume
[304.817305] Subtest suspend-resume: SKIP (0.000s)
[304.937313] [068/133] (715s left) perf (gen12-oa-tlb-invalidate)
[305.037545] Starting subtest: gen12-oa-tlb-invalidate
[305.039470] Starting dynamic subtest: 0-rcs0
[315.088411] Dynamic subtest 0-rcs0: SUCCESS (10.050s)
[315.096803] Starting dynamic subtest: 1-vecs0
[325.187174] Dynamic subtest 1-vecs0: SUCCESS (10.045s)
[325.189530] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.098s)
[325.227915] [069/133] (695s left) prime_vgem (fence-read-hang)
[325.311618] Subtest fence-read-hang: SKIP (0.000s)
[325.427793] [070/133] (695s left) syncobj_basic (bad-create-flags)
[325.475629] Starting subtest: bad-create-flags
[325.477644] Subtest bad-create-flags: SUCCESS (0.000s)
[325.590609] [071/133] (694s left) kms_setmode (basic)
[325.645266] Starting subtest: basic
[325.980208] Starting dynamic subtest: pipe-A-eDP-1
[328.078210] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.094s)
[328.425920] Starting dynamic subtest: pipe-B-eDP-1
[330.509261] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.087s)
[330.822394] Subtest basic: SUCCESS (5.175s)
[331.649180] [072/133] (688s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[331.705131] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[331.809812] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[331.883698] [073/133] (688s left) gem_vm_create (invalid-create)
[331.937065] Starting subtest: invalid-create
[331.939419] Subtest invalid-create: SUCCESS (0.002s)
[332.041134] [074/133] (688s left) kms_prop_blob (invalid-get-prop)
[332.097127] Starting subtest: invalid-get-prop
[332.099336] Subtest invalid-get-prop: SUCCESS (0.000s)
[332.210264] [075/133] (688s left) gem_exec_alignment (pi-isolated)
[332.274090] Starting subtest: pi-isolated
[383.728075] Subtest pi-isolated: SUCCESS (51.452s)
[384.707534] [076/133] (636s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[384.858610] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[384.863079] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[384.975568] [077/133] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[385.071757] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[385.076103] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[385.163444] [078/133] (635s left) gem_ctx_exec (basic-norecovery)
[385.229350] Starting subtest: basic-norecovery
[385.560548] Subtest basic-norecovery: SUCCESS (0.332s)
[385.688961] [079/133] (635s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[385.778332] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[385.780193] Starting dynamic subtest: pipe-A-eDP-1
[385.800469] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[385.811435] Starting dynamic subtest: pipe-B-eDP-1
[385.828973] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[385.838118] Starting dynamic subtest: pipe-C-eDP-1
[385.855683] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[385.864421] Starting dynamic subtest: pipe-D-eDP-1
[385.883160] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[385.886510] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[387.928796] [080/133] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[388.026507] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[388.030803] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[388.127756] [081/133] (632s left) kms_getfb (getfb2-handle-not-fb)
[388.221342] Starting subtest: getfb2-handle-not-fb
[388.223609] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[388.316585] [082/133] (632s left) gem_mmap_offset (partial-remap)
[388.375017] Starting subtest: partial-remap
[388.377285] Starting dynamic subtest: smem0
[388.386124] Dynamic subtest smem0: SUCCESS (0.003s)
[388.388340] Subtest partial-remap: SUCCESS (0.004s)
[388.470770] [083/133] (632s left) kms_psr (pr-suspend)
[388.567206] Starting subtest: pr-suspend
[388.571603] Subtest pr-suspend: SKIP (0.000s)
[388.638943] [084/133] (632s left) kms_plane_alpha_blend (alpha-basic)
[388.737931] Starting subtest: alpha-basic
[389.026096] Starting dynamic subtest: pipe-A-eDP-1
[390.940299] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.912s)
[390.973694] Starting dynamic subtest: pipe-D-eDP-1
[393.628188] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.666s)
[393.630603] Subtest alpha-basic: SUCCESS (4.890s)
[394.495261] [085/133] (626s left) gem_set_tiling_vs_gtt
[394.618908] [086/133] (626s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[394.713143] Starting subtest: yf-tiled-16bpp-rotate-90
[394.717680] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[394.805699] [087/133] (626s left) kms_psr (psr2-suspend)
[394.896873] Starting subtest: psr2-suspend
[394.899107] Starting dynamic subtest: eDP-1
[412.474610] Dynamic subtest eDP-1: SUCCESS (3.731s)
[412.476854] Subtest psr2-suspend: SUCCESS (3.732s)
[413.297112] [088/133] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[413.427721] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[413.432220] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[413.539341] [089/133] (607s left) gem_ctx_create (basic)
[413.597008] Starting subtest: basic
[413.599249] Subtest basic: SUCCESS (0.000s)
[413.784445] [090/133] (607s left) kms_pm_dc (dc5-retention-flops)
[414.908642] Starting subtest: dc5-retention-flops
[414.913279] Subtest dc5-retention-flops: SKIP (0.000s)
[414.986484] [091/133] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[415.085140] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[415.089799] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[415.171904] [092/133] (606s left) kms_sequence (get-forked-busy)
[415.268182] Starting subtest: get-forked-busy
[415.270626] Starting dynamic subtest: pipe-A-eDP-1
[417.256065] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[417.268848] Starting dynamic subtest: pipe-B-eDP-1
[419.939986] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.632s)
[419.951241] Starting dynamic subtest: pipe-C-eDP-1
[422.601803] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.628s)
[422.613023] Starting dynamic subtest: pipe-D-eDP-1
[425.244395] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.617s)
[425.246966] Subtest get-forked-busy: SUCCESS (9.823s)
[426.141742] [093/133] (595s left) dmabuf_sync_file (import-multiple-read-write)
[426.187909] Starting subtest: import-multiple-read-write
[426.189968] Subtest import-multiple-read-write: SUCCESS (0.005s)
[426.277465] [094/133] (595s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[426.383380] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[426.387784] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[426.499267] [095/133] (595s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[426.593538] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[426.595787] Starting dynamic subtest: pipe-A-eDP-1
[426.616134] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[426.628137] Starting dynamic subtest: pipe-B-eDP-1
[426.647755] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[426.656909] Starting dynamic subtest: pipe-C-eDP-1
[426.676303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[426.685579] Starting dynamic subtest: pipe-D-eDP-1
[426.706449] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[426.708528] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[428.926382] [096/133] (592s left) gem_exec_flush (basic-uc-prw-default)
[428.984206] Starting subtest: basic-uc-prw-default
[434.486431] Subtest basic-uc-prw-default: SUCCESS (5.474s)
[434.668385] [097/133] (586s left) gem_exec_reloc (basic-wc)
[434.722980] Subtest basic-wc: SKIP (0.000s)
[434.796468] [098/133] (586s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[434.901101] Starting subtest: y-tiled-64bpp-rotate-90
[434.905427] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[434.998986] [099/133] (586s left) i915_suspend (debugfs-reader)
[435.062178] Starting subtest: debugfs-reader
[453.047823] Subtest debugfs-reader: SUCCESS (3.093s)
[453.192761] [100/133] (568s left) gem_exec_params (invalid-bsd-ring)
[453.255274] Starting subtest: invalid-bsd-ring
[453.258106] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[453.350776] [101/133] (568s left) kms_plane_scaling (planes-upscale-factor-0-25)
[453.449201] Starting subtest: planes-upscale-factor-0-25
[453.452028] Starting dynamic subtest: pipe-A
[453.510113] Dynamic subtest pipe-A: SUCCESS (0.063s)
[453.522280] Starting dynamic subtest: pipe-B
[454.660949] Dynamic subtest pipe-B: SUCCESS (1.148s)
[454.673686] Starting dynamic subtest: pipe-C
[455.774070] Dynamic subtest pipe-C: SUCCESS (1.108s)
[455.786017] Starting dynamic subtest: pipe-D
[456.910092] Dynamic subtest pipe-D: SUCCESS (1.137s)
[456.912946] Subtest planes-upscale-factor-0-25: SUCCESS (3.459s)
[458.080165] [102/133] (563s left) i915_pm_freq_api (freq-reset)
[458.151971] Starting subtest: freq-reset
[458.154791] Starting dynamic subtest: gt0
[458.343055] Dynamic subtest gt0: SUCCESS (0.189s)
[458.353287] Starting dynamic subtest: gt1
[458.510631] Dynamic subtest gt1: SUCCESS (0.166s)
[458.513441] Subtest freq-reset: SUCCESS (0.358s)
[458.586665] [103/133] (563s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[458.705892] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[458.711016] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[458.785024] [104/133] (563s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[458.839216] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[458.939564] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[459.016594] [105/133] (563s left) syncobj_wait (wait-for-submit-snapshot)
[459.082283] Starting subtest: wait-for-submit-snapshot
[459.162643] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[459.240970] [106/133] (562s left) kms_pm_rpm (pm-tiling)
[460.793014] Starting subtest: pm-tiling
[460.799944] Subtest pm-tiling: SKIP (0.000s)
[461.528683] [107/133] (560s left) gem_mmap_gtt (cpuset-basic-small-copy)
[461.599067] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[461.672360] [108/133] (560s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[461.780414] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[465.558204] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.780s)
[466.743167] [109/133] (555s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[466.793406] Starting subtest: single-wait-all-for-submit-available-submitted
[466.796014] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[466.912648] [110/133] (555s left) kms_rotation_crc (primary-rotation-180)
[466.998761] Starting subtest: primary-rotation-180
[474.126999] Subtest primary-rotation-180: SUCCESS (7.123s)
[475.295331] [111/133] (547s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[475.390493] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[475.395364] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[475.507731] [112/133] (546s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[475.593867] Starting subtest: primary-4-tiled-reflect-x-0
[482.937924] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.343s)
[484.091717] [113/133] (538s left) kms_plane_lowres (tiling-x)
[484.187161] Starting subtest: tiling-x
[484.190167] Starting dynamic subtest: pipe-A-eDP-1
[484.195961] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[484.494716] Starting dynamic subtest: pipe-B-eDP-1
[484.500466] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[484.511478] Starting dynamic subtest: pipe-C-eDP-1
[484.517308] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[484.530491] Starting dynamic subtest: pipe-D-eDP-1
[484.535689] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[484.540986] Subtest tiling-x: SKIP (0.294s)
[485.369559] [114/133] (537s left) kms_lease (lease-revoke)
[485.466625] Starting subtest: lease-revoke
[485.469163] Starting dynamic subtest: pipe-A-eDP-1
[485.501033] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[485.523323] Starting dynamic subtest: pipe-B-eDP-1
[485.526016] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[485.546380] Starting dynamic subtest: pipe-C-eDP-1
[485.557572] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[485.568042] Starting dynamic subtest: pipe-D-eDP-1
[485.586050] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[485.588611] Subtest lease-revoke: SUCCESS (0.120s)
[485.694609] [115/133] (536s left) kms_hdr (static-toggle-dpms)
[485.789306] Starting subtest: static-toggle-dpms
[485.797140] Subtest static-toggle-dpms: SKIP (0.000s)
[485.878081] [116/133] (536s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[485.968269] Starting subtest: primary-yf-tiled-reflect-x-270
[485.973852] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[486.055535] [117/133] (536s left) gem_ccs (block-copy-uncompressed)
[486.118937] Starting subtest: block-copy-uncompressed
[486.121970] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[486.143591] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[486.154934] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[486.161058] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[486.171049] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[486.178475] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[486.188316] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[486.195868] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[486.198565] Subtest block-copy-uncompressed: SUCCESS (0.075s)
[486.312712] [118/133] (536s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[486.402224] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[486.404828] Starting dynamic subtest: pipe-A-eDP-1
[486.428138] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[486.439971] Starting dynamic subtest: pipe-B-eDP-1
[486.463718] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[486.473134] Starting dynamic subtest: pipe-C-eDP-1
[486.496962] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[486.506984] Starting dynamic subtest: pipe-D-eDP-1
[486.531240] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[486.536077] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[488.621547] [119/133] (534s left) vgem_basic (setversion)
[488.673130] Starting subtest: setversion
[488.678287] Subtest setversion: SUCCESS (0.000s)
[488.735542] [120/133] (534s left) api_intel_bb (purge-bb)
[488.787750] Starting subtest: purge-bb
[488.790292] Subtest purge-bb: SUCCESS (0.004s)
[488.908560] [121/133] (533s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[489.029285] Starting subtest: cursorB-vs-flipA-toggle
[489.038637] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[489.192683] [122/133] (533s left) kms_draw_crc (draw-method-pwrite)
[489.293090] Starting subtest: draw-method-pwrite
[489.295256] Starting dynamic subtest: xrgb8888-untiled
[489.980045] Dynamic subtest xrgb8888-untiled: SUCCESS (0.677s)
[489.990324] Starting dynamic subtest: rgb565-untiled
[490.533134] Dynamic subtest rgb565-untiled: SUCCESS (0.542s)
[490.544062] Starting dynamic subtest: xrgb2101010-untiled
[491.153157] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.610s)
[491.163886] Starting dynamic subtest: xbgr16161616f-untiled
[491.998532] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.833s)
[492.009288] Starting dynamic subtest: xrgb8888-xtiled
[494.190070] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.165s)
[494.201219] Starting dynamic subtest: rgb565-xtiled
[495.590594] Dynamic subtest rgb565-xtiled: SUCCESS (1.386s)
[495.601525] Starting dynamic subtest: xrgb2101010-xtiled
[497.794944] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.188s)
[497.805075] Starting dynamic subtest: xbgr16161616f-xtiled
[501.602988] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.788s)
[501.613732] Starting dynamic subtest: xrgb8888-4tiled
[502.920008] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.310s)
[502.930249] Starting dynamic subtest: rgb565-4tiled
[503.621161] Dynamic subtest rgb565-4tiled: SUCCESS (0.698s)
[503.631743] Starting dynamic subtest: xrgb2101010-4tiled
[504.947090] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.321s)
[504.962564] Starting dynamic subtest: xbgr16161616f-4tiled
[508.332937] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.377s)
[508.335613] Subtest draw-method-pwrite: SUCCESS (18.912s)
[508.427988] [123/133] (514s left) kms_flip (dpms-off-confusion-interruptible)
[508.517680] Starting subtest: dpms-off-confusion-interruptible
[508.520139] Starting dynamic subtest: A-eDP1
[517.212903] Dynamic subtest A-eDP1: SUCCESS (8.649s)
[517.227883] Starting dynamic subtest: B-eDP1
[525.859498] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[525.872398] Starting dynamic subtest: C-eDP1
[534.500014] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[534.512098] Starting dynamic subtest: D-eDP1
[543.143987] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[543.147167] Subtest dpms-off-confusion-interruptible: SUCCESS (34.553s)
[544.268641] [124/133] (478s left) kms_atomic (atomic-invalid-params)
[544.370311] Starting subtest: atomic-invalid-params
[544.372904] Starting dynamic subtest: pipe-A-eDP-1
[544.757269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s)
[544.760215] Subtest atomic-invalid-params: SUCCESS (0.389s)
[545.590812] [125/133] (477s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[545.668817] Starting subtest: map-fixed-invalidate-overlap-busy
[545.673598] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[545.790194] [126/133] (477s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[545.879046] Starting subtest: plane-all-modeset-transition-fencing
[545.884204] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[545.959845] [127/133] (477s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[546.046477] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[546.051847] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[546.121006] [128/133] (477s left) gem_exec_balancer (bonded-false-hang)
[546.378281] Starting subtest: bonded-false-hang
[546.384082] Subtest bonded-false-hang: SKIP (0.000s)
[546.465781] [129/133] (476s left) kms_chamelium_edid (hdmi-edid-read)
[546.842474] Subtest hdmi-edid-read: SKIP (0.000s)
[547.611007] [130/133] (475s left) gem_tiled_partial_pwrite_pread (reads)
[547.671879] Subtest reads: SKIP (0.000s)
[547.734801] [131/133] (475s left) kms_big_fb (linear-32bpp-rotate-180)
[547.832293] Starting subtest: linear-32bpp-rotate-180
[549.335905] Subtest linear-32bpp-rotate-180: SUCCESS (1.501s)
[549.454399] [132/133] (473s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[550.006088] Starting subtest: syncobj-timeline-invalid-flags
[550.009105] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[551.718810] [133/133] (471s left) gem_ppgtt (shrink-vs-evict-pinned)
[551.785284] Starting subtest: shrink-vs-evict-pinned
[559.553568] Subtest shrink-vs-evict-pinned: SUCCESS (7.766s)
[559.640204] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: vgem_basic
results: parsing output: 5/ for test: kms_fence_pin_leak
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: gem_exec_basic
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: core_auth
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_chamelium_frames
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_spin_batch
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_dither
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: sw_sync
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: i915_pm_rpm
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_color_pipeline
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_reg_read
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ccs
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: prime_vgem
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: kms_setmode
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_vm_create
results: parsing output: 73/ for test: kms_prop_blob
results: parsing output: 74/ for test: gem_exec_alignment
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ctx_exec
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_getfb
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_plane_alpha_blend
results: parsing output: 84/ for test: gem_set_tiling_vs_gtt
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_create
results: parsing output: 89/ for test: kms_pm_dc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_sequence
results: parsing output: 92/ for test: dmabuf_sync_file
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_exec_flush
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: i915_suspend
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: i915_pm_freq_api
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: kms_plane_lowres
results: parsing output: 113/ for test: kms_lease
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: gem_ccs
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_atomic
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_atomic_transition
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_chamelium_edid
results: parsing output: 129/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_exec_fence
results: parsing output: 132/ for test: gem_ppgtt
Done.