[61.811401] Initializing watchdogs
[61.811497]   /dev/watchdog0
[61.826796] [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]
[61.831661] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.834345] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.836463] [001/133] (960s left) gem_userptr_blits (sync-unmap)
[61.897501] Starting subtest: sync-unmap
[61.924711] Subtest sync-unmap: SUCCESS (0.027s)
[62.041427] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[62.141873] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[62.143727] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[62.233670] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[62.320292] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[62.322037] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[62.409557] [004/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[62.500047] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[63.578998] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.079s)
[63.709187] [005/133] (958s left) vgem_basic (busy-fence)
[63.764343] Starting subtest: busy-fence
[63.765225] Subtest busy-fence: SUCCESS (0.000s)
[63.812590] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[63.814206] [006/133] (958s left) kms_fence_pin_leak
[63.973952] [007/133] (958s left) gem_exec_reloc (basic-cpu-wc)
[64.032984] Subtest basic-cpu-wc: SKIP (0.000s)
[64.103119] [008/133] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[64.204372] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[72.361114] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (8.159s)
[72.479861] [009/133] (950s left) gem_exec_fence (syncobj-timeline-signal)
[73.026794] Starting subtest: syncobj-timeline-signal
[73.028277] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[74.015800] [010/133] (948s left) gem_exec_basic (basic)
[74.067629] Starting subtest: basic
[74.068871] Starting dynamic subtest: rcs0-smem
[74.072765] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[74.088357] Starting dynamic subtest: bcs0-smem
[74.089342] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[74.095664] Starting dynamic subtest: vcs0-smem
[74.096537] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[74.105434] Starting dynamic subtest: vcs1-smem
[74.106222] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[74.111675] Starting dynamic subtest: vecs0-smem
[74.112477] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[74.118039] Starting dynamic subtest: ccs0-smem
[74.118847] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[74.119701] Subtest basic: SUCCESS (0.022s)
[75.912096] [011/133] (946s left) kms_flip (dpms-vs-vblank-race-interruptible)
[76.010987] Starting subtest: dpms-vs-vblank-race-interruptible
[76.012205] Starting dynamic subtest: A-eDP1
[80.964656] Dynamic subtest A-eDP1: SUCCESS (4.952s)
[80.974820] Starting dynamic subtest: B-eDP1
[84.487883] Dynamic subtest B-eDP1: SUCCESS (3.521s)
[84.495030] Starting dynamic subtest: C-eDP1
[88.001681] Dynamic subtest C-eDP1: SUCCESS (3.513s)
[88.008647] Starting dynamic subtest: D-eDP1
[92.620052] Dynamic subtest D-eDP1: SUCCESS (4.617s)
[92.621025] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.610s)
[93.505086] [012/133] (929s left) gem_exec_schedule (pi-userfault)
[93.694698] Starting subtest: pi-userfault
[93.695928] Starting dynamic subtest: rcs0
[93.697096] Dynamic subtest rcs0: SUCCESS (0.013s)
[93.705007] Starting dynamic subtest: bcs0
[93.706030] Dynamic subtest bcs0: SUCCESS (0.008s)
[93.712188] Starting dynamic subtest: vcs0
[93.714190] Dynamic subtest vcs0: SUCCESS (0.009s)
[93.720835] Starting dynamic subtest: vcs1
[93.724249] Dynamic subtest vcs1: SUCCESS (0.010s)
[93.732310] Starting dynamic subtest: vecs0
[93.734044] Dynamic subtest vecs0: SUCCESS (0.010s)
[93.740993] Starting dynamic subtest: ccs0
[93.743304] Dynamic subtest ccs0: SUCCESS (0.009s)
[93.744172] Subtest pi-userfault: SUCCESS (0.059s)
[93.921497] [013/133] (928s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[94.019469] Starting subtest: yf-tiled-64bpp-rotate-180
[94.021439] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[94.107559] [014/133] (928s left) core_auth (many-magics)
[94.157968] Starting subtest: many-magics
[95.043573] Subtest many-magics: SUCCESS (0.886s)
[95.158586] [015/133] (927s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[95.240474] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[95.241383] Starting dynamic subtest: pipe-A-eDP-1
[95.389996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[95.398341] Starting dynamic subtest: pipe-B-eDP-1
[95.406803] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.017s)
[95.413026] Starting dynamic subtest: pipe-C-eDP-1
[95.420774] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[95.426853] Starting dynamic subtest: pipe-D-eDP-1
[95.434781] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[95.435686] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.189s)
[97.662517] [016/133] (925s left) gem_mmap_wc (write-read)
[97.723396] Subtest write-read: SKIP (0.000s)
[97.782103] [017/133] (925s left) kms_cursor_crc (cursor-onscreen-512x512)
[98.063956] Starting subtest: cursor-onscreen-512x512
[98.066029] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[98.199065] [018/133] (924s left) kms_chamelium_frames (vga-frame-dump)
[98.563446] Subtest vga-frame-dump: SKIP (0.000s)
[99.371411] [019/133] (923s left) kms_plane_scaling (invalid-num-scalers)
[99.461094] Starting subtest: invalid-num-scalers
[99.461938] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[99.480725] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[99.487540] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[99.515539] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[99.525210] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[99.554324] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[99.560412] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[99.594263] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[99.595043] Subtest invalid-num-scalers: SUCCESS (0.127s)
[99.678446] [020/133] (923s left) gem_exec_reloc (basic-write-wc-active)
[99.729583] Subtest basic-write-wc-active: SKIP (0.000s)
[99.792693] [021/133] (923s left) perf_pmu (init-busy)
[99.827541] Starting subtest: init-busy
[99.828543] Starting dynamic subtest: rcs0
[99.829493] Dynamic subtest rcs0: SUCCESS (0.002s)
[99.836532] Starting dynamic subtest: bcs0
[99.837550] Dynamic subtest bcs0: SUCCESS (0.001s)
[99.843980] Starting dynamic subtest: vcs0
[99.844958] Dynamic subtest vcs0: SUCCESS (0.001s)
[99.851358] Starting dynamic subtest: vcs1
[99.852452] Dynamic subtest vcs1: SUCCESS (0.001s)
[99.858612] Starting dynamic subtest: vecs0
[99.859558] Dynamic subtest vecs0: SUCCESS (0.001s)
[99.865691] Starting dynamic subtest: ccs0
[99.866633] Dynamic subtest ccs0: SUCCESS (0.001s)
[99.867530] Subtest init-busy: SUCCESS (0.009s)
[99.952377] [022/133] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[100.035921] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[100.037766] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[100.116723] [023/133] (922s left) gem_lmem_swapping (heavy-verify-random)
[100.156816] Subtest heavy-verify-random: SKIP (0.000s)
[100.191747] [024/133] (922s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[100.282059] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[100.284138] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[101.428673] [025/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[101.528390] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[101.530162] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[101.608955] [026/133] (921s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[101.653696] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[101.656354] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[101.756660] [027/133] (921s left) kms_content_protection (type1)
[101.888266] Starting subtest: type1
[101.890403] Subtest type1: SKIP (0.000s)
[102.004782] [028/133] (921s left) prime_vgem (fence-wait)
[102.068311] Starting subtest: fence-wait
[102.069219] Starting dynamic subtest: rcs0
[103.115532] Dynamic subtest rcs0: SUCCESS (1.038s)
[103.122542] Starting dynamic subtest: bcs0
[104.168548] Dynamic subtest bcs0: SUCCESS (1.051s)
[104.176619] Starting dynamic subtest: vcs0
[105.208829] Dynamic subtest vcs0: SUCCESS (1.039s)
[105.216067] Starting dynamic subtest: vcs1
[106.252401] Dynamic subtest vcs1: SUCCESS (1.042s)
[106.261225] Starting dynamic subtest: vecs0
[107.294682] Dynamic subtest vecs0: SUCCESS (1.041s)
[107.303657] Starting dynamic subtest: ccs0
[108.339077] Dynamic subtest ccs0: SUCCESS (1.042s)
[108.340237] Subtest fence-wait: SUCCESS (6.262s)
[108.435120] [029/133] (914s left) syncobj_timeline (invalid-signal-zero-handles)
[108.480145] Starting subtest: invalid-signal-zero-handles
[108.481081] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[108.570530] [030/133] (914s left) gem_mmap_wc (coherency)
[108.612822] Subtest coherency: SKIP (0.000s)
[108.651936] [031/133] (914s left) gem_mmap_gtt (basic-short)
[108.712361] Subtest basic-short: SKIP (0.000s)
[108.768454] [032/133] (914s left) perf (per-context-mode-unprivileged)
[108.892659] Starting subtest: per-context-mode-unprivileged
[108.894325] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[108.923933] [033/133] (914s left) kms_chamelium_audio (dp-audio-edid)
[109.305177] Subtest dp-audio-edid: SKIP (0.000s)
[110.130438] [034/133] (913s left) gen9_exec_parse (cmd-crossing-page)
[110.185902] Subtest cmd-crossing-page: SKIP (0.000s)
[110.239846] [035/133] (913s left) gem_spin_batch (user-each)
[110.298373] Starting subtest: user-each
[113.565334] Subtest user-each: SUCCESS (3.259s)
[114.022641] [036/133] (909s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[114.120179] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[114.121082] Starting dynamic subtest: pipe-A-default-mode
[116.922346] Dynamic subtest pipe-A-default-mode: SUCCESS (2.802s)
[116.923292] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.803s)
[117.749349] [037/133] (905s left) gem_userptr_blits (create-destroy-unsync)
[117.809310] Subtest create-destroy-unsync: SKIP (0.000s)
[117.929652] [038/133] (905s left) kms_cursor_crc (cursor-sliding-512x512)
[118.181229] Starting subtest: cursor-sliding-512x512
[118.183067] Subtest cursor-sliding-512x512: SKIP (0.001s)
[118.351432] [039/133] (905s left) gem_ctx_persistence (heartbeat-many)
[118.403176] Starting subtest: heartbeat-many
[118.404926] Subtest heartbeat-many: SKIP (0.000s)
[118.493762] [040/133] (905s left) gem_exec_whisper (basic-forked-all)
[118.549517] Starting subtest: basic-forked-all
[131.873580] Subtest basic-forked-all: SUCCESS (13.313s)
[132.044848] [041/133] (891s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[132.138686] Starting subtest: fbcpsr-tiling-4
[139.277809] Subtest fbcpsr-tiling-4: SUCCESS (7.140s)
[139.407645] [042/133] (884s left) kms_psr (fbc-psr2-sprite-plane-move)
[139.494161] Starting subtest: fbc-psr2-sprite-plane-move
[139.495310] Starting dynamic subtest: eDP-1
[139.497530] Dynamic subtest eDP-1: SKIP (0.000s)
[139.499254] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[139.578349] [043/133] (884s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[139.668423] Starting subtest: fb-8bpc-vs-panel-6bpc
[139.669286] Starting dynamic subtest: pipe-A-eDP-1
[141.048409] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.377s)
[141.049388] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.379s)
[141.830125] [044/133] (881s left) kms_vblank (query-idle-hang)
[141.926124] Starting subtest: query-idle-hang
[141.926965] Starting dynamic subtest: pipe-A-eDP-1
[169.695441] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.766s)
[169.705757] Starting dynamic subtest: pipe-D-eDP-1
[193.680125] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.982s)
[193.681085] Subtest query-idle-hang: SUCCESS (51.753s)
[194.494186] [045/133] (829s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[194.583281] Starting subtest: async-flip-with-page-flip-events-linear
[194.957735] Starting dynamic subtest: pipe-A-eDP-1
[197.790970] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.823s)
[198.167918] Starting dynamic subtest: pipe-B-eDP-1
[200.929597] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[201.284453] Starting dynamic subtest: pipe-C-eDP-1
[204.055794] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[204.417215] Starting dynamic subtest: pipe-D-eDP-1
[207.184412] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[207.185672] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.591s)
[208.371708] [046/133] (815s left) sw_sync (alloc_fence_invalid_timeline)
[208.408785] Starting subtest: alloc_fence_invalid_timeline
[208.409913] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[208.470403] [047/133] (815s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[208.558398] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[208.559497] Starting dynamic subtest: pipe-A-default-mode
[211.325212] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[211.326094] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.767s)
[212.164982] [048/133] (811s left) kms_flip (2x-flip-vs-wf_vblank)
[212.261945] Starting subtest: 2x-flip-vs-wf_vblank
[212.272905] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[212.346867] [049/133] (811s left) kms_flip (2x-nonexisting-fb)
[212.441376] Starting subtest: 2x-nonexisting-fb
[212.452138] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[212.528611] [050/133] (811s left) gem_exec_schedule (promotion)
[212.606177] Starting subtest: promotion
[212.607619] Starting dynamic subtest: rcs0
[212.714074] Dynamic subtest rcs0: SUCCESS (0.107s)
[212.723886] Starting dynamic subtest: vcs0
[212.806525] Dynamic subtest vcs0: SUCCESS (0.092s)
[212.815825] Starting dynamic subtest: vcs1
[212.890143] Dynamic subtest vcs1: SUCCESS (0.081s)
[212.904652] Starting dynamic subtest: vecs0
[212.967773] Dynamic subtest vecs0: SUCCESS (0.078s)
[212.977919] Starting dynamic subtest: ccs0
[213.055425] Dynamic subtest ccs0: SUCCESS (0.087s)
[213.057487] Subtest promotion: SUCCESS (0.450s)
[214.023640] [051/133] (809s left) kms_cursor_crc (cursor-random-max-size)
[214.336202] Starting subtest: cursor-random-max-size
[214.339452] Subtest cursor-random-max-size: SKIP (0.000s)
[214.516362] [052/133] (809s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[214.600189] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[221.967054] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.368s)
[222.099635] [053/133] (801s left) kms_flip (flip-vs-blocking-wf-vblank)
[222.190150] Starting subtest: flip-vs-blocking-wf-vblank
[222.191067] Starting dynamic subtest: A-eDP1
[231.152936] Dynamic subtest A-eDP1: SUCCESS (8.962s)
[231.161525] Starting dynamic subtest: B-eDP1
[240.087737] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[240.098093] Starting dynamic subtest: C-eDP1
[249.055264] Dynamic subtest C-eDP1: SUCCESS (8.928s)
[249.065234] Starting dynamic subtest: D-eDP1
[257.977132] Dynamic subtest D-eDP1: SUCCESS (8.919s)
[257.978045] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.757s)
[259.185760] [054/133] (764s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[259.282047] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[259.283056] Starting dynamic subtest: pipe-A-eDP-1
[275.748844] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.467s)
[275.757315] Starting dynamic subtest: pipe-B-eDP-1
[292.947621] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.195s)
[292.948423] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.666s)
[293.732369] [055/133] (730s left) i915_drm_fdinfo (most-busy-check-all)
[293.765261] Starting subtest: most-busy-check-all
[293.766126] Starting dynamic subtest: rcs0
[293.769532] Dynamic subtest rcs0: SKIP (0.003s)
[293.777066] Starting dynamic subtest: bcs0
[293.778811] Dynamic subtest bcs0: SKIP (0.000s)
[293.785753] Starting dynamic subtest: vcs0
[293.787430] Dynamic subtest vcs0: SKIP (0.000s)
[293.794428] Starting dynamic subtest: vcs1
[293.796164] Dynamic subtest vcs1: SKIP (0.000s)
[293.803338] Starting dynamic subtest: vecs0
[293.805023] Dynamic subtest vecs0: SKIP (0.000s)
[293.811785] Starting dynamic subtest: ccs0
[293.813650] Dynamic subtest ccs0: SKIP (0.000s)
[293.815349] Subtest most-busy-check-all: SKIP (0.009s)
[293.843431] [056/133] (730s left) gem_pxp (verify-pxp-stale-buf-execution)
[293.987051] Starting subtest: verify-pxp-stale-buf-execution
[295.050997] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[295.156098] [057/133] (729s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[295.203333] Starting subtest: y-tiled-ccs-to-yf-tiled
[295.204961] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[295.382597] [058/133] (728s left) i915_pm_rpm (gem-idle)
[297.119873] Starting subtest: gem-idle
[303.320038] Subtest gem-idle: SUCCESS (6.202s)
[303.656350] [059/133] (720s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[304.897648] Starting subtest: y-tiled-ccs-to-y-tiled
[304.899860] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[305.077136] [060/133] (719s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[305.170588] Starting subtest: fbc-psr2-cursor-mmap-gtt
[305.171700] Starting dynamic subtest: eDP-1
[305.173531] Dynamic subtest eDP-1: SKIP (0.000s)
[305.175270] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[305.257306] [061/133] (719s left) kms_color_pipeline (plane-ctm3x4)
[305.342670] Starting subtest: plane-ctm3x4
[305.512404] Starting dynamic subtest: pipe-A-plane-0
[305.660708] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[305.669543] Starting dynamic subtest: pipe-A-plane-1
[305.767744] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s)
[305.775271] Starting dynamic subtest: pipe-A-plane-2
[305.923540] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[307.150639] Starting dynamic subtest: pipe-B-plane-0
[307.288631] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[307.297653] Starting dynamic subtest: pipe-B-plane-1
[307.454879] Dynamic subtest pipe-B-plane-1: SUCCESS (0.164s)
[307.462593] Starting dynamic subtest: pipe-B-plane-2
[307.588128] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[308.785106] Starting dynamic subtest: pipe-C-plane-0
[308.889455] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[308.897094] Starting dynamic subtest: pipe-C-plane-1
[309.000766] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[309.008526] Starting dynamic subtest: pipe-C-plane-2
[309.111803] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[310.322357] Starting dynamic subtest: pipe-D-plane-0
[310.426180] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[310.434439] Starting dynamic subtest: pipe-D-plane-1
[310.559514] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[310.567669] Starting dynamic subtest: pipe-D-plane-2
[310.681598] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s)
[310.967027] Subtest plane-ctm3x4: SUCCESS (5.624s)
[311.788955] [062/133] (712s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[311.884730] Starting subtest: x-tiled-8bpp-rotate-180
[313.087475] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.203s)
[313.242539] [063/133] (711s left) perf_pmu (invalid-init)
[313.299697] Starting subtest: invalid-init
[313.300880] Subtest invalid-init: SUCCESS (0.000s)
[313.416312] [064/133] (711s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[313.503269] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[313.504973] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[313.601676] [065/133] (710s left) gem_reg_read (bad-register)
[313.647488] Starting subtest: bad-register
[313.648421] Subtest bad-register: SUCCESS (0.000s)
[313.747593] [066/133] (710s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[313.832268] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[313.833868] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[313.926683] [067/133] (710s left) gem_ccs (suspend-resume)
[313.988334] Starting subtest: suspend-resume
[313.990946] Subtest suspend-resume: SKIP (0.000s)
[314.105690] [068/133] (710s left) perf (gen12-oa-tlb-invalidate)
[314.207981] Starting subtest: gen12-oa-tlb-invalidate
[314.209065] Starting dynamic subtest: 0-rcs0
[324.304903] Dynamic subtest 0-rcs0: SUCCESS (10.051s)
[324.314595] Starting dynamic subtest: 1-vcs1
[334.355588] Dynamic subtest 1-vcs1: SUCCESS (10.048s)
[334.357188] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.101s)
[334.391317] [069/133] (690s left) prime_vgem (fence-read-hang)
[334.459694] Subtest fence-read-hang: SKIP (0.000s)
[334.546049] [070/133] (690s left) syncobj_basic (bad-create-flags)
[334.588523] Starting subtest: bad-create-flags
[334.589471] Subtest bad-create-flags: SUCCESS (0.000s)
[334.673396] [071/133] (690s left) kms_setmode (basic)
[334.726945] Starting subtest: basic
[335.055292] Starting dynamic subtest: pipe-A-eDP-1
[337.108256] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.042s)
[337.442147] Starting dynamic subtest: pipe-B-eDP-1
[339.535052] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.089s)
[339.833702] Subtest basic: SUCCESS (5.106s)
[340.666392] [072/133] (684s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[340.724210] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[340.826785] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[340.911291] [073/133] (683s left) gem_vm_create (invalid-create)
[340.965328] Starting subtest: invalid-create
[340.967552] Subtest invalid-create: SUCCESS (0.002s)
[341.082028] [074/133] (683s left) kms_prop_blob (invalid-get-prop)
[341.129979] Starting subtest: invalid-get-prop
[341.130965] Subtest invalid-get-prop: SUCCESS (0.000s)
[341.218776] [075/133] (683s left) gem_exec_alignment (pi-isolated)
[341.281028] Starting subtest: pi-isolated
[394.013323] Subtest pi-isolated: SUCCESS (52.727s)
[395.258306] [076/133] (629s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[395.387281] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[395.389064] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[395.477208] [077/133] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[395.574844] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[395.576476] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[395.678519] [078/133] (629s left) gem_ctx_exec (basic-norecovery)
[395.734250] Starting subtest: basic-norecovery
[396.087342] Subtest basic-norecovery: SUCCESS (0.353s)
[396.205063] [079/133] (628s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[396.299923] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[396.300672] Starting dynamic subtest: pipe-A-eDP-1
[396.308079] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[396.316080] Starting dynamic subtest: pipe-B-eDP-1
[396.323597] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[396.331355] Starting dynamic subtest: pipe-C-eDP-1
[396.341040] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[396.349073] Starting dynamic subtest: pipe-D-eDP-1
[396.357260] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[396.358766] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[398.441174] [080/133] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[398.534550] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[398.536337] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[398.632700] [081/133] (626s left) kms_getfb (getfb2-handle-not-fb)
[398.715467] Starting subtest: getfb2-handle-not-fb
[398.716407] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[398.818479] [082/133] (626s left) gem_mmap_offset (partial-remap)
[398.868054] Starting subtest: partial-remap
[398.869214] Starting dynamic subtest: smem0
[398.880375] Dynamic subtest smem0: SUCCESS (0.008s)
[398.881516] Subtest partial-remap: SUCCESS (0.009s)
[398.964843] [083/133] (626s left) kms_psr (pr-suspend)
[399.061401] Starting subtest: pr-suspend
[399.062988] Subtest pr-suspend: SKIP (0.000s)
[399.141067] [084/133] (626s left) kms_plane_alpha_blend (alpha-basic)
[399.239127] Starting subtest: alpha-basic
[399.591554] Starting dynamic subtest: pipe-A-eDP-1
[401.513060] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.921s)
[401.547869] Starting dynamic subtest: pipe-D-eDP-1
[404.229123] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.695s)
[404.229964] Subtest alpha-basic: SUCCESS (4.990s)
[405.111507] [085/133] (620s left) gem_set_tiling_vs_gtt
[405.230064] [086/133] (620s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[405.338972] Starting subtest: yf-tiled-16bpp-rotate-90
[405.340778] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[405.429302] [087/133] (619s left) kms_psr (psr2-suspend)
[405.527226] Starting subtest: psr2-suspend
[405.528173] Starting dynamic subtest: eDP-1
[423.688361] Dynamic subtest eDP-1: SUCCESS (4.192s)
[423.689961] Subtest psr2-suspend: SUCCESS (4.192s)
[430.589499] [088/133] (600s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[430.691144] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[430.693263] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[430.793247] [089/133] (600s left) gem_ctx_create (basic)
[430.855944] Starting subtest: basic
[430.857181] Subtest basic: SUCCESS (0.000s)
[431.048976] [090/133] (600s left) kms_pm_dc (dc5-retention-flops)
[432.143020] Starting subtest: dc5-retention-flops
[432.144833] Subtest dc5-retention-flops: SKIP (0.000s)
[432.215494] [091/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[432.310653] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[432.312402] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[432.416403] [092/133] (599s left) kms_sequence (get-forked-busy)
[432.511305] Starting subtest: get-forked-busy
[432.512277] Starting dynamic subtest: pipe-A-eDP-1
[434.455810] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[434.464913] Starting dynamic subtest: pipe-B-eDP-1
[437.092443] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.635s)
[437.103026] Starting dynamic subtest: pipe-C-eDP-1
[439.713220] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s)
[439.727808] Starting dynamic subtest: pipe-D-eDP-1
[442.328477] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.612s)
[442.329649] Subtest get-forked-busy: SUCCESS (9.814s)
[443.128368] [093/133] (588s left) dmabuf_sync_file (import-multiple-read-write)
[443.171489] Starting subtest: import-multiple-read-write
[443.174238] Subtest import-multiple-read-write: SUCCESS (0.004s)
[443.238227] [094/133] (588s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[443.337681] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[443.339496] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[443.440976] [095/133] (588s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[443.524590] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[443.525439] Starting dynamic subtest: pipe-A-eDP-1
[443.532845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[443.542242] Starting dynamic subtest: pipe-B-eDP-1
[443.549233] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[443.558101] Starting dynamic subtest: pipe-C-eDP-1
[443.564991] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[443.573682] Starting dynamic subtest: pipe-D-eDP-1
[443.580175] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[443.580891] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[445.796183] [096/133] (585s left) gem_exec_flush (basic-uc-prw-default)
[445.862943] Starting subtest: basic-uc-prw-default
[451.327748] Subtest basic-uc-prw-default: SUCCESS (5.464s)
[451.525314] [097/133] (580s left) gem_exec_reloc (basic-wc)
[451.580999] Subtest basic-wc: SKIP (0.000s)
[451.651345] [098/133] (580s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[451.759321] Starting subtest: y-tiled-64bpp-rotate-90
[451.761099] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[451.866897] [099/133] (579s left) i915_suspend (debugfs-reader)
[451.918622] Starting subtest: debugfs-reader
[470.267080] Subtest debugfs-reader: SUCCESS (3.531s)
[475.458318] [100/133] (561s left) gem_exec_params (invalid-bsd-ring)
[475.510341] Starting subtest: invalid-bsd-ring
[475.511309] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[475.608903] [101/133] (561s left) kms_plane_scaling (planes-upscale-factor-0-25)
[475.707835] Starting subtest: planes-upscale-factor-0-25
[475.708985] Starting dynamic subtest: pipe-A
[475.770194] Dynamic subtest pipe-A: SUCCESS (0.062s)
[475.783442] Starting dynamic subtest: pipe-B
[477.085245] Dynamic subtest pipe-B: SUCCESS (1.311s)
[477.098468] Starting dynamic subtest: pipe-C
[478.197057] Dynamic subtest pipe-C: SUCCESS (1.110s)
[478.206499] Starting dynamic subtest: pipe-D
[479.340927] Dynamic subtest pipe-D: SUCCESS (1.143s)
[479.342081] Subtest planes-upscale-factor-0-25: SUCCESS (3.634s)
[480.495658] [102/133] (556s left) i915_pm_freq_api (freq-reset)
[480.578153] Starting subtest: freq-reset
[480.578992] Starting dynamic subtest: gt0
[480.771750] Dynamic subtest gt0: SUCCESS (0.193s)
[480.780772] Starting dynamic subtest: gt1
[480.951004] Dynamic subtest gt1: SUCCESS (0.171s)
[480.952440] Subtest freq-reset: SUCCESS (0.366s)
[481.034439] [103/133] (556s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[481.123896] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[481.125752] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[481.206333] [104/133] (555s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[481.263954] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[481.365520] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[481.438739] [105/133] (555s left) syncobj_wait (wait-for-submit-snapshot)
[481.487995] Starting subtest: wait-for-submit-snapshot
[481.578328] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[481.646850] [106/133] (555s left) kms_pm_rpm (pm-tiling)
[483.902658] Starting subtest: pm-tiling
[483.905515] Subtest pm-tiling: SKIP (0.000s)
[484.305510] [107/133] (552s left) gem_mmap_gtt (cpuset-basic-small-copy)
[484.355240] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[484.409614] [108/133] (552s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[484.498293] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[488.161366] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.663s)
[489.282416] [109/133] (547s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[489.330313] Starting subtest: single-wait-all-for-submit-available-submitted
[489.331425] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[489.421335] [110/133] (547s left) kms_rotation_crc (primary-rotation-180)
[489.511541] Starting subtest: primary-rotation-180
[496.551050] Subtest primary-rotation-180: SUCCESS (7.040s)
[497.763139] [111/133] (539s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[497.851064] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[497.852752] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[497.943069] [112/133] (539s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[498.031422] Starting subtest: primary-4-tiled-reflect-x-0
[505.087685] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.057s)
[506.323182] [113/133] (531s left) kms_plane_lowres (tiling-x)
[506.427446] Starting subtest: tiling-x
[506.428372] Starting dynamic subtest: pipe-A-eDP-1
[506.430127] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[506.723989] Starting dynamic subtest: pipe-B-eDP-1
[506.726070] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[506.735069] Starting dynamic subtest: pipe-C-eDP-1
[506.737188] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[506.747357] Starting dynamic subtest: pipe-D-eDP-1
[506.749322] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[506.751343] Subtest tiling-x: SKIP (0.294s)
[507.557420] [114/133] (529s left) kms_lease (lease-revoke)
[507.664850] Starting subtest: lease-revoke
[507.665800] Starting dynamic subtest: pipe-A-eDP-1
[507.696783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[507.710711] Starting dynamic subtest: pipe-B-eDP-1
[507.723012] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[507.733004] Starting dynamic subtest: pipe-C-eDP-1
[507.752472] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[507.762807] Starting dynamic subtest: pipe-D-eDP-1
[507.778607] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[507.779526] Subtest lease-revoke: SUCCESS (0.115s)
[507.905379] [115/133] (529s left) kms_hdr (static-toggle-dpms)
[508.006245] Starting subtest: static-toggle-dpms
[508.008741] Subtest static-toggle-dpms: SKIP (0.000s)
[508.084136] [116/133] (529s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[508.173284] Starting subtest: primary-yf-tiled-reflect-x-270
[508.175776] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[508.245338] [117/133] (529s left) gem_ccs (block-copy-uncompressed)
[508.303900] Starting subtest: block-copy-uncompressed
[508.304921] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[508.324927] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[508.336270] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[508.346007] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[508.355048] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[508.363595] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[508.375309] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[508.380524] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[508.381565] Subtest block-copy-uncompressed: SUCCESS (0.079s)
[508.512805] [118/133] (529s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[508.601416] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[508.602460] Starting dynamic subtest: pipe-A-eDP-1
[508.610635] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[508.620208] Starting dynamic subtest: pipe-B-eDP-1
[508.628605] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[508.637965] Starting dynamic subtest: pipe-C-eDP-1
[508.645924] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[508.654502] Starting dynamic subtest: pipe-D-eDP-1
[508.662610] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[508.664426] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[510.904087] [119/133] (526s left) vgem_basic (setversion)
[510.950122] Starting subtest: setversion
[510.951878] Subtest setversion: SUCCESS (0.000s)
[511.003910] [120/133] (526s left) api_intel_bb (purge-bb)
[511.052988] Starting subtest: purge-bb
[511.056823] Subtest purge-bb: SUCCESS (0.005s)
[511.186900] [121/133] (526s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[511.311599] Starting subtest: cursorB-vs-flipA-toggle
[511.313742] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[511.454340] [122/133] (526s left) kms_draw_crc (draw-method-pwrite)
[511.537501] Starting subtest: draw-method-pwrite
[511.538646] Starting dynamic subtest: xrgb8888-untiled
[512.137755] Dynamic subtest xrgb8888-untiled: SUCCESS (0.600s)
[512.146949] Starting dynamic subtest: rgb565-untiled
[512.593997] Dynamic subtest rgb565-untiled: SUCCESS (0.455s)
[512.603698] Starting dynamic subtest: xrgb2101010-untiled
[513.172642] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.577s)
[513.182646] Starting dynamic subtest: xbgr16161616f-untiled
[513.973456] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.799s)
[513.982988] Starting dynamic subtest: xrgb8888-xtiled
[515.864355] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.888s)
[515.873891] Starting dynamic subtest: rgb565-xtiled
[516.998838] Dynamic subtest rgb565-xtiled: SUCCESS (1.133s)
[517.008158] Starting dynamic subtest: xrgb2101010-xtiled
[518.900676] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.899s)
[518.917176] Starting dynamic subtest: xbgr16161616f-xtiled
[522.469498] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.566s)
[522.478802] Starting dynamic subtest: xrgb8888-4tiled
[523.659062] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.188s)
[523.668489] Starting dynamic subtest: rgb565-4tiled
[524.237784] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s)
[524.247411] Starting dynamic subtest: xrgb2101010-4tiled
[525.404190] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.166s)
[525.413916] Starting dynamic subtest: xbgr16161616f-4tiled
[528.617062] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.210s)
[528.618043] Subtest draw-method-pwrite: SUCCESS (17.067s)
[528.719169] [123/133] (509s left) kms_flip (dpms-off-confusion-interruptible)
[528.815782] Starting subtest: dpms-off-confusion-interruptible
[528.818172] Starting dynamic subtest: A-eDP1
[537.548773] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[537.564931] Starting dynamic subtest: B-eDP1
[546.197087] Dynamic subtest B-eDP1: SUCCESS (8.647s)
[546.210371] Starting dynamic subtest: C-eDP1
[554.824917] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[554.836521] Starting dynamic subtest: D-eDP1
[563.461568] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[563.462751] Subtest dpms-off-confusion-interruptible: SUCCESS (34.608s)
[564.604213] [124/133] (473s left) kms_atomic (atomic-invalid-params)
[564.687489] Starting subtest: atomic-invalid-params
[564.688394] Starting dynamic subtest: pipe-A-eDP-1
[565.097048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[565.097934] Subtest atomic-invalid-params: SUCCESS (0.410s)
[565.940103] [125/133] (471s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[566.007849] Starting subtest: map-fixed-invalidate-overlap-busy
[566.009611] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[566.134058] [126/133] (471s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[566.226416] Starting subtest: plane-all-modeset-transition-fencing
[566.228168] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[566.293664] [127/133] (471s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[566.375087] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[566.376781] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[566.446482] [128/133] (471s left) gem_exec_balancer (bonded-false-hang)
[566.714543] Starting subtest: bonded-false-hang
[566.716706] Subtest bonded-false-hang: SKIP (0.000s)
[566.815658] [129/133] (471s left) kms_chamelium_edid (hdmi-edid-read)
[567.199718] Subtest hdmi-edid-read: SKIP (0.000s)
[568.050362] [130/133] (469s left) gem_tiled_partial_pwrite_pread (reads)
[568.114380] Subtest reads: SKIP (0.000s)
[568.185137] [131/133] (469s left) kms_big_fb (linear-32bpp-rotate-180)
[568.286278] Starting subtest: linear-32bpp-rotate-180
[569.845303] Subtest linear-32bpp-rotate-180: SUCCESS (1.558s)
[569.972288] [132/133] (468s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[570.549902] Starting subtest: syncobj-timeline-invalid-flags
[570.551353] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[571.810984] [133/133] (466s left) gem_ppgtt (shrink-vs-evict-pinned)
[571.863690] Starting subtest: shrink-vs-evict-pinned
[579.756063] Subtest shrink-vs-evict-pinned: SUCCESS (7.844s)
[579.799243] 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.