[58.235542] Initializing watchdogs
[58.235595]   /dev/watchdog0
[58.250268] [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]
[58.255418] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.257739] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.259621] [001/133] (960s left) gem_userptr_blits (sync-unmap)
[58.334878] Starting subtest: sync-unmap
[58.355720] Subtest sync-unmap: SUCCESS (0.021s)
[58.471982] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[58.559875] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[58.561551] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[58.644789] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[58.736912] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[58.738880] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[58.835409] [004/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[58.931470] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[60.028922] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.103s)
[60.150231] [005/133] (958s left) vgem_basic (busy-fence)
[60.225010] Starting subtest: busy-fence
[60.226357] Subtest busy-fence: SUCCESS (0.000s)
[60.272201] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[60.273855] [006/133] (958s left) kms_fence_pin_leak
[60.443625] [007/133] (958s left) gem_exec_reloc (basic-cpu-wc)
[60.497013] Subtest basic-cpu-wc: SKIP (0.000s)
[60.554470] [008/133] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[60.640136] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[68.828321] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (8.208s)
[68.934944] [009/133] (950s left) gem_exec_fence (syncobj-timeline-signal)
[69.475620] Starting subtest: syncobj-timeline-signal
[69.476964] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[71.011165] [010/133] (948s left) gem_exec_basic (basic)
[71.054501] Starting subtest: basic
[71.055614] Starting dynamic subtest: rcs0-smem
[71.058207] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[71.067063] Starting dynamic subtest: bcs0-smem
[71.068055] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[71.074232] Starting dynamic subtest: vcs0-smem
[71.075063] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[71.080953] Starting dynamic subtest: vcs1-smem
[71.081797] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[71.087813] Starting dynamic subtest: vecs0-smem
[71.088694] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[71.094547] Starting dynamic subtest: ccs0-smem
[71.095417] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[71.096293] Subtest basic: SUCCESS (0.014s)
[72.950839] [011/133] (946s left) kms_flip (dpms-vs-vblank-race-interruptible)
[73.040118] Starting subtest: dpms-vs-vblank-race-interruptible
[73.042257] Starting dynamic subtest: A-eDP1
[76.856358] Dynamic subtest A-eDP1: SUCCESS (3.814s)
[76.862756] Starting dynamic subtest: B-eDP1
[81.501395] Dynamic subtest B-eDP1: SUCCESS (4.645s)
[81.509966] Starting dynamic subtest: C-eDP1
[86.109387] Dynamic subtest C-eDP1: SUCCESS (4.605s)
[86.116261] Starting dynamic subtest: D-eDP1
[90.733121] Dynamic subtest D-eDP1: SUCCESS (4.622s)
[90.736340] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.697s)
[91.627328] [012/133] (927s left) gem_exec_schedule (pi-userfault)
[91.807285] Starting subtest: pi-userfault
[91.808409] Starting dynamic subtest: rcs0
[91.809496] Dynamic subtest rcs0: SUCCESS (0.012s)
[91.818059] Starting dynamic subtest: bcs0
[91.818924] Dynamic subtest bcs0: SUCCESS (0.009s)
[91.825464] Starting dynamic subtest: vcs0
[91.826421] Dynamic subtest vcs0: SUCCESS (0.007s)
[91.835879] Starting dynamic subtest: vcs1
[91.836700] Dynamic subtest vcs1: SUCCESS (0.007s)
[91.843689] Starting dynamic subtest: vecs0
[91.844524] Dynamic subtest vecs0: SUCCESS (0.006s)
[91.851293] Starting dynamic subtest: ccs0
[91.852106] Dynamic subtest ccs0: SUCCESS (0.006s)
[91.852919] Subtest pi-userfault: SUCCESS (0.050s)
[92.023184] [013/133] (927s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[92.125623] Starting subtest: yf-tiled-64bpp-rotate-180
[92.127423] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[92.228836] [014/133] (926s left) core_auth (many-magics)
[92.277398] Starting subtest: many-magics
[93.131205] Subtest many-magics: SUCCESS (0.855s)
[93.278941] [015/133] (925s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[93.364361] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[93.365106] Starting dynamic subtest: pipe-A-eDP-1
[93.511711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s)
[93.521937] Starting dynamic subtest: pipe-B-eDP-1
[93.528722] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[93.534953] Starting dynamic subtest: pipe-C-eDP-1
[93.541501] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[93.547743] Starting dynamic subtest: pipe-D-eDP-1
[93.554378] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[93.555277] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.177s)
[95.770223] [016/133] (923s left) gem_mmap_wc (write-read)
[95.820122] Subtest write-read: SKIP (0.000s)
[95.869648] [017/133] (923s left) kms_cursor_crc (cursor-onscreen-512x512)
[96.163097] Starting subtest: cursor-onscreen-512x512
[96.164913] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[96.324833] [018/133] (922s left) kms_chamelium_frames (vga-frame-dump)
[96.695564] Subtest vga-frame-dump: SKIP (0.000s)
[97.478108] [019/133] (921s left) kms_plane_scaling (invalid-num-scalers)
[97.557300] Starting subtest: invalid-num-scalers
[97.558581] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[97.577069] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[97.583605] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[97.609779] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[97.616370] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[97.642892] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[97.651178] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[97.677060] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[97.677929] Subtest invalid-num-scalers: SUCCESS (0.121s)
[97.790313] [020/133] (921s left) gem_exec_reloc (basic-write-wc-active)
[97.838070] Subtest basic-write-wc-active: SKIP (0.000s)
[97.889418] [021/133] (921s left) perf_pmu (init-busy)
[97.924332] Starting subtest: init-busy
[97.925200] Starting dynamic subtest: rcs0
[97.926229] Dynamic subtest rcs0: SUCCESS (0.001s)
[97.935186] Starting dynamic subtest: bcs0
[97.936052] Dynamic subtest bcs0: SUCCESS (0.000s)
[97.942343] Starting dynamic subtest: vcs0
[97.943209] Dynamic subtest vcs0: SUCCESS (0.001s)
[97.949861] Starting dynamic subtest: vcs1
[97.950777] Dynamic subtest vcs1: SUCCESS (0.001s)
[97.956785] Starting dynamic subtest: vecs0
[97.957666] Dynamic subtest vecs0: SUCCESS (0.001s)
[97.963869] Starting dynamic subtest: ccs0
[97.964714] Dynamic subtest ccs0: SUCCESS (0.000s)
[97.965840] Subtest init-busy: SUCCESS (0.006s)
[98.038710] [022/133] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[98.125998] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[98.127788] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[98.238912] [023/133] (921s left) gem_lmem_swapping (heavy-verify-random)
[98.272276] Subtest heavy-verify-random: SKIP (0.000s)
[98.311828] [024/133] (921s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[98.397137] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[98.398850] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[99.529353] [025/133] (919s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[99.617231] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[99.618920] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[99.704537] [026/133] (919s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[99.749172] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[99.750148] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[99.858425] [027/133] (919s left) kms_content_protection (type1)
[100.000556] Starting subtest: type1
[100.002762] Subtest type1: SKIP (0.000s)
[100.122268] [028/133] (919s left) prime_vgem (fence-wait)
[100.198258] Starting subtest: fence-wait
[100.199315] Starting dynamic subtest: rcs0
[101.253994] Dynamic subtest rcs0: SUCCESS (1.046s)
[101.262519] Starting dynamic subtest: bcs0
[102.303533] Dynamic subtest bcs0: SUCCESS (1.048s)
[102.312308] Starting dynamic subtest: vcs0
[103.351779] Dynamic subtest vcs0: SUCCESS (1.047s)
[103.361656] Starting dynamic subtest: vcs1
[104.389636] Dynamic subtest vcs1: SUCCESS (1.036s)
[104.398713] Starting dynamic subtest: vecs0
[105.435532] Dynamic subtest vecs0: SUCCESS (1.045s)
[105.445415] Starting dynamic subtest: ccs0
[106.480978] Dynamic subtest ccs0: SUCCESS (1.044s)
[106.482199] Subtest fence-wait: SUCCESS (6.274s)
[106.601166] [029/133] (913s left) syncobj_timeline (invalid-signal-zero-handles)
[106.665858] Starting subtest: invalid-signal-zero-handles
[106.667041] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[106.754862] [030/133] (912s left) gem_mmap_wc (coherency)
[106.805953] Subtest coherency: SKIP (0.000s)
[106.857782] [031/133] (912s left) gem_mmap_gtt (basic-short)
[106.903836] Subtest basic-short: SKIP (0.000s)
[106.956278] [032/133] (912s left) perf (per-context-mode-unprivileged)
[107.078179] Starting subtest: per-context-mode-unprivileged
[107.079914] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[107.112337] [033/133] (912s left) kms_chamelium_audio (dp-audio-edid)
[107.488225] Subtest dp-audio-edid: SKIP (0.000s)
[108.346807] [034/133] (911s left) gen9_exec_parse (cmd-crossing-page)
[108.392786] Subtest cmd-crossing-page: SKIP (0.000s)
[108.451831] [035/133] (911s left) gem_spin_batch (user-each)
[108.511025] Starting subtest: user-each
[111.783876] Subtest user-each: SUCCESS (3.267s)
[111.957292] [036/133] (907s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[112.072977] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[112.073921] Starting dynamic subtest: pipe-A-default-mode
[114.831339] Dynamic subtest pipe-A-default-mode: SUCCESS (2.757s)
[114.832297] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.758s)
[115.658795] [037/133] (904s left) gem_userptr_blits (create-destroy-unsync)
[115.715256] Subtest create-destroy-unsync: SKIP (0.000s)
[115.837979] [038/133] (904s left) kms_cursor_crc (cursor-sliding-512x512)
[116.109495] Starting subtest: cursor-sliding-512x512
[116.111420] Subtest cursor-sliding-512x512: SKIP (0.001s)
[116.280640] [039/133] (903s left) gem_ctx_persistence (heartbeat-many)
[116.345185] Starting subtest: heartbeat-many
[116.347083] Subtest heartbeat-many: SKIP (0.000s)
[116.461444] [040/133] (903s left) gem_exec_whisper (basic-forked-all)
[116.522365] Starting subtest: basic-forked-all
[129.890793] Subtest basic-forked-all: SUCCESS (13.356s)
[130.074797] [041/133] (890s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[130.168629] Starting subtest: fbcpsr-tiling-4
[137.281503] Subtest fbcpsr-tiling-4: SUCCESS (7.114s)
[137.423101] [042/133] (882s left) kms_psr (fbc-psr2-sprite-plane-move)
[137.519990] Starting subtest: fbc-psr2-sprite-plane-move
[137.521092] Starting dynamic subtest: eDP-1
[137.522792] Dynamic subtest eDP-1: SKIP (0.000s)
[137.524541] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[137.585551] [043/133] (882s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[137.669707] Starting subtest: fb-8bpc-vs-panel-6bpc
[137.670526] Starting dynamic subtest: pipe-A-eDP-1
[139.099057] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.429s)
[139.099904] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.430s)
[139.970899] [044/133] (880s left) kms_vblank (query-idle-hang)
[140.071382] Starting subtest: query-idle-hang
[140.072364] Starting dynamic subtest: pipe-A-eDP-1
[166.677775] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.604s)
[166.686970] Starting dynamic subtest: pipe-D-eDP-1
[191.641024] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.961s)
[191.642172] Subtest query-idle-hang: SUCCESS (51.569s)
[192.442109] [045/133] (827s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[192.520412] Starting subtest: async-flip-with-page-flip-events-linear
[192.897432] Starting dynamic subtest: pipe-A-eDP-1
[195.722744] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.816s)
[196.076862] Starting dynamic subtest: pipe-B-eDP-1
[198.847039] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[199.209536] Starting dynamic subtest: pipe-C-eDP-1
[201.971364] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.757s)
[202.342304] Starting dynamic subtest: pipe-D-eDP-1
[205.097267] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.751s)
[205.098678] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.568s)
[206.279807] [046/133] (813s left) sw_sync (alloc_fence_invalid_timeline)
[206.317267] Starting subtest: alloc_fence_invalid_timeline
[206.318370] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[206.369339] [047/133] (813s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[206.457612] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[206.458529] Starting dynamic subtest: pipe-A-default-mode
[209.195209] Dynamic subtest pipe-A-default-mode: SUCCESS (2.737s)
[209.196148] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.738s)
[210.057533] [048/133] (810s left) kms_flip (2x-flip-vs-wf_vblank)
[210.151840] Starting subtest: 2x-flip-vs-wf_vblank
[210.169451] Subtest 2x-flip-vs-wf_vblank: SKIP (0.017s)
[210.249751] [049/133] (810s left) kms_flip (2x-nonexisting-fb)
[210.338605] Starting subtest: 2x-nonexisting-fb
[210.349835] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[210.423579] [050/133] (809s left) gem_exec_schedule (promotion)
[210.486433] Starting subtest: promotion
[210.487569] Starting dynamic subtest: rcs0
[210.593069] Dynamic subtest rcs0: SUCCESS (0.108s)
[210.603138] Starting dynamic subtest: vcs0
[210.681722] Dynamic subtest vcs0: SUCCESS (0.087s)
[210.691683] Starting dynamic subtest: vcs1
[210.768404] Dynamic subtest vcs1: SUCCESS (0.086s)
[210.779252] Starting dynamic subtest: vecs0
[210.850616] Dynamic subtest vecs0: SUCCESS (0.081s)
[210.865075] Starting dynamic subtest: ccs0
[210.934439] Dynamic subtest ccs0: SUCCESS (0.083s)
[210.935899] Subtest promotion: SUCCESS (0.450s)
[211.941359] [051/133] (808s left) kms_cursor_crc (cursor-random-max-size)
[212.240204] Starting subtest: cursor-random-max-size
[212.242539] Subtest cursor-random-max-size: SKIP (0.000s)
[212.352990] [052/133] (808s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[212.454551] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[219.865649] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.412s)
[219.997343] [053/133] (800s left) kms_flip (flip-vs-blocking-wf-vblank)
[220.090889] Starting subtest: flip-vs-blocking-wf-vblank
[220.093191] Starting dynamic subtest: A-eDP1
[229.065168] Dynamic subtest A-eDP1: SUCCESS (8.972s)
[229.074162] Starting dynamic subtest: B-eDP1
[238.006272] Dynamic subtest B-eDP1: SUCCESS (8.940s)
[238.016788] Starting dynamic subtest: C-eDP1
[246.963769] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[246.973718] Starting dynamic subtest: D-eDP1
[255.872833] Dynamic subtest D-eDP1: SUCCESS (8.944s)
[255.876674] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.783s)
[257.087291] [054/133] (763s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[257.183871] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[257.184801] Starting dynamic subtest: pipe-A-eDP-1
[273.670345] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.485s)
[273.677739] Starting dynamic subtest: pipe-B-eDP-1
[290.874077] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.202s)
[290.874913] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.690s)
[291.660806] [055/133] (728s left) i915_drm_fdinfo (most-busy-check-all)
[291.704906] Starting subtest: most-busy-check-all
[291.705682] Starting dynamic subtest: rcs0
[291.709496] Dynamic subtest rcs0: SKIP (0.004s)
[291.717293] Starting dynamic subtest: bcs0
[291.718889] Dynamic subtest bcs0: SKIP (0.000s)
[291.726374] Starting dynamic subtest: vcs0
[291.727966] Dynamic subtest vcs0: SKIP (0.000s)
[291.734946] Starting dynamic subtest: vcs1
[291.736731] Dynamic subtest vcs1: SKIP (0.001s)
[291.746606] Starting dynamic subtest: vecs0
[291.748254] Dynamic subtest vecs0: SKIP (0.001s)
[291.754950] Starting dynamic subtest: ccs0
[291.756702] Dynamic subtest ccs0: SKIP (0.001s)
[291.758531] Subtest most-busy-check-all: SKIP (0.018s)
[291.791077] [056/133] (728s left) gem_pxp (verify-pxp-stale-buf-execution)
[291.917281] Starting subtest: verify-pxp-stale-buf-execution
[292.980739] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[293.105373] [057/133] (727s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[293.162941] Starting subtest: y-tiled-ccs-to-yf-tiled
[293.164798] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[293.339938] [058/133] (727s left) i915_pm_rpm (gem-idle)
[295.083199] Starting subtest: gem-idle
[301.274575] Subtest gem-idle: SUCCESS (6.193s)
[301.622235] [059/133] (719s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[302.850323] Starting subtest: y-tiled-ccs-to-y-tiled
[302.852517] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[303.038572] [060/133] (717s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[303.125337] Starting subtest: fbc-psr2-cursor-mmap-gtt
[303.126254] Starting dynamic subtest: eDP-1
[303.127897] Dynamic subtest eDP-1: SKIP (0.000s)
[303.129609] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[303.194719] [061/133] (717s left) kms_color_pipeline (plane-ctm3x4)
[303.285464] Starting subtest: plane-ctm3x4
[303.479305] Starting dynamic subtest: pipe-A-plane-0
[303.621739] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[303.629595] Starting dynamic subtest: pipe-A-plane-1
[303.755085] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[303.762971] Starting dynamic subtest: pipe-A-plane-2
[303.888363] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[305.127837] Starting dynamic subtest: pipe-B-plane-0
[305.264985] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[305.272880] Starting dynamic subtest: pipe-B-plane-1
[305.398636] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[305.410289] Starting dynamic subtest: pipe-B-plane-2
[305.520613] Dynamic subtest pipe-B-plane-2: SUCCESS (0.121s)
[306.774311] Starting dynamic subtest: pipe-C-plane-0
[306.900382] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[306.908120] Starting dynamic subtest: pipe-C-plane-1
[307.045295] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[307.054587] Starting dynamic subtest: pipe-C-plane-2
[307.200278] Dynamic subtest pipe-C-plane-2: SUCCESS (0.153s)
[308.399865] Starting dynamic subtest: pipe-D-plane-0
[308.498988] Dynamic subtest pipe-D-plane-0: SUCCESS (0.110s)
[308.506790] Starting dynamic subtest: pipe-D-plane-1
[308.610471] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[308.620121] Starting dynamic subtest: pipe-D-plane-2
[308.721265] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[309.007925] Subtest plane-ctm3x4: SUCCESS (5.722s)
[309.841570] [062/133] (710s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[309.942524] Starting subtest: x-tiled-8bpp-rotate-180
[311.138054] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.204s)
[311.255974] [063/133] (709s left) perf_pmu (invalid-init)
[311.292917] Starting subtest: invalid-init
[311.294105] Subtest invalid-init: SUCCESS (0.000s)
[311.391401] [064/133] (709s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[311.480840] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[311.482636] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[311.569770] [065/133] (709s left) gem_reg_read (bad-register)
[311.623424] Starting subtest: bad-register
[311.624485] Subtest bad-register: SUCCESS (0.000s)
[311.739261] [066/133] (709s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[311.838360] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[311.840089] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[311.935281] [067/133] (709s left) gem_ccs (suspend-resume)
[311.983741] Starting subtest: suspend-resume
[311.985650] Subtest suspend-resume: SKIP (0.000s)
[312.079744] [068/133] (708s left) perf (gen12-oa-tlb-invalidate)
[312.175455] Starting subtest: gen12-oa-tlb-invalidate
[312.176528] Starting dynamic subtest: 0-rcs0
[322.271109] Dynamic subtest 0-rcs0: SUCCESS (10.050s)
[322.280804] Starting dynamic subtest: 1-vecs0
[332.320741] Dynamic subtest 1-vecs0: SUCCESS (10.047s)
[332.322555] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.100s)
[332.354955] [069/133] (688s left) prime_vgem (fence-read-hang)
[332.427693] Subtest fence-read-hang: SKIP (0.000s)
[332.518635] [070/133] (688s left) syncobj_basic (bad-create-flags)
[332.577952] Starting subtest: bad-create-flags
[332.579044] Subtest bad-create-flags: SUCCESS (0.000s)
[332.665599] [071/133] (688s left) kms_setmode (basic)
[332.711387] Starting subtest: basic
[333.047987] Starting dynamic subtest: pipe-A-eDP-1
[335.171201] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.113s)
[335.506245] Starting dynamic subtest: pipe-B-eDP-1
[337.599993] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.091s)
[337.899821] Subtest basic: SUCCESS (5.186s)
[338.737390] [072/133] (682s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[338.780742] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[338.882376] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[338.980369] [073/133] (682s left) gem_vm_create (invalid-create)
[339.033427] Starting subtest: invalid-create
[339.034352] Subtest invalid-create: SUCCESS (0.002s)
[339.121998] [074/133] (682s left) kms_prop_blob (invalid-get-prop)
[339.166058] Starting subtest: invalid-get-prop
[339.167205] Subtest invalid-get-prop: SUCCESS (0.000s)
[339.253476] [075/133] (681s left) gem_exec_alignment (pi-isolated)
[339.301311] Starting subtest: pi-isolated
[392.873933] Subtest pi-isolated: SUCCESS (53.568s)
[394.030359] [076/133] (627s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[394.177675] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[394.179408] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[394.263297] [077/133] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[394.352318] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[394.353960] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[394.470708] [078/133] (626s left) gem_ctx_exec (basic-norecovery)
[394.516883] Starting subtest: basic-norecovery
[394.871281] Subtest basic-norecovery: SUCCESS (0.353s)
[394.987776] [079/133] (626s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[395.069730] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[395.071166] Starting dynamic subtest: pipe-A-eDP-1
[395.081513] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[395.095531] Starting dynamic subtest: pipe-B-eDP-1
[395.104612] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[395.118082] Starting dynamic subtest: pipe-C-eDP-1
[395.126156] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[395.134157] Starting dynamic subtest: pipe-D-eDP-1
[395.142889] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[395.144698] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[397.301381] [080/133] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[397.399921] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[397.401766] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[397.529840] [081/133] (623s left) kms_getfb (getfb2-handle-not-fb)
[397.627045] Starting subtest: getfb2-handle-not-fb
[397.628160] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[397.723745] [082/133] (623s left) gem_mmap_offset (partial-remap)
[397.769899] Starting subtest: partial-remap
[397.770956] Starting dynamic subtest: smem0
[397.774468] Dynamic subtest smem0: SUCCESS (0.004s)
[397.775253] Subtest partial-remap: SUCCESS (0.004s)
[397.878161] [083/133] (623s left) kms_psr (pr-suspend)
[397.970397] Starting subtest: pr-suspend
[397.971974] Subtest pr-suspend: SKIP (0.000s)
[398.051911] [084/133] (623s left) kms_plane_alpha_blend (alpha-basic)
[398.154583] Starting subtest: alpha-basic
[398.531648] Starting dynamic subtest: pipe-A-eDP-1
[400.453359] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s)
[400.482458] Starting dynamic subtest: pipe-D-eDP-1
[403.111048] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.636s)
[403.112220] Subtest alpha-basic: SUCCESS (4.957s)
[403.977133] [085/133] (617s left) gem_set_tiling_vs_gtt
[404.087386] [086/133] (617s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[404.186452] Starting subtest: yf-tiled-16bpp-rotate-90
[404.188358] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[404.284803] [087/133] (617s left) kms_psr (psr2-suspend)
[404.371412] Starting subtest: psr2-suspend
[404.372330] Starting dynamic subtest: eDP-1
[422.363425] Dynamic subtest eDP-1: SUCCESS (4.127s)
[422.364258] Subtest psr2-suspend: SUCCESS (4.128s)
[428.310376] [088/133] (598s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[428.423963] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[428.425506] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[428.529176] [089/133] (598s left) gem_ctx_create (basic)
[428.578784] Starting subtest: basic
[428.579685] Subtest basic: SUCCESS (0.000s)
[428.756106] [090/133] (598s left) kms_pm_dc (dc5-retention-flops)
[429.857366] Starting subtest: dc5-retention-flops
[429.859200] Subtest dc5-retention-flops: SKIP (0.000s)
[429.938775] [091/133] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[430.032753] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[430.034342] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[430.128673] [092/133] (596s left) kms_sequence (get-forked-busy)
[430.220487] Starting subtest: get-forked-busy
[430.221421] Starting dynamic subtest: pipe-A-eDP-1
[432.129818] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[432.138970] Starting dynamic subtest: pipe-B-eDP-1
[434.782548] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.681s)
[434.791392] Starting dynamic subtest: pipe-C-eDP-1
[437.346281] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.584s)
[437.357697] Starting dynamic subtest: pipe-D-eDP-1
[439.981507] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.649s)
[439.982440] Subtest get-forked-busy: SUCCESS (9.857s)
[440.850612] [093/133] (586s left) dmabuf_sync_file (import-multiple-read-write)
[440.889105] Starting subtest: import-multiple-read-write
[440.892439] Subtest import-multiple-read-write: SUCCESS (0.004s)
[440.942359] [094/133] (586s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[441.035339] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[441.036802] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[441.188854] [095/133] (585s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[441.279876] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[441.280855] Starting dynamic subtest: pipe-A-eDP-1
[441.288734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[441.298295] Starting dynamic subtest: pipe-B-eDP-1
[441.306597] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[441.317352] Starting dynamic subtest: pipe-C-eDP-1
[441.324556] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[441.333151] Starting dynamic subtest: pipe-D-eDP-1
[441.340222] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[441.340979] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[443.520289] [096/133] (583s left) gem_exec_flush (basic-uc-prw-default)
[443.571354] Starting subtest: basic-uc-prw-default
[449.020807] Subtest basic-uc-prw-default: SUCCESS (5.462s)
[449.215491] [097/133] (577s left) gem_exec_reloc (basic-wc)
[449.270780] Subtest basic-wc: SKIP (0.000s)
[449.346756] [098/133] (577s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[449.440486] Starting subtest: y-tiled-64bpp-rotate-90
[449.442365] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[449.533375] [099/133] (577s left) i915_suspend (debugfs-reader)
[449.580654] Starting subtest: debugfs-reader
[467.947603] Subtest debugfs-reader: SUCCESS (3.562s)
[475.078645] [100/133] (559s left) gem_exec_params (invalid-bsd-ring)
[475.122302] Starting subtest: invalid-bsd-ring
[475.123151] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[475.209016] [101/133] (559s left) kms_plane_scaling (planes-upscale-factor-0-25)
[475.302053] Starting subtest: planes-upscale-factor-0-25
[475.303035] Starting dynamic subtest: pipe-A
[475.362468] Dynamic subtest pipe-A: SUCCESS (0.062s)
[475.372683] Starting dynamic subtest: pipe-B
[476.506210] Dynamic subtest pipe-B: SUCCESS (1.166s)
[476.516918] Starting dynamic subtest: pipe-C
[477.606869] Dynamic subtest pipe-C: SUCCESS (1.119s)
[477.616888] Starting dynamic subtest: pipe-D
[478.711464] Dynamic subtest pipe-D: SUCCESS (1.119s)
[478.712705] Subtest planes-upscale-factor-0-25: SUCCESS (3.471s)
[479.857650] [102/133] (554s left) i915_pm_freq_api (freq-reset)
[479.916011] Starting subtest: freq-reset
[479.916912] Starting dynamic subtest: gt0
[480.108290] Dynamic subtest gt0: SUCCESS (0.194s)
[480.118229] Starting dynamic subtest: gt1
[480.289914] Dynamic subtest gt1: SUCCESS (0.173s)
[480.291414] Subtest freq-reset: SUCCESS (0.370s)
[480.351073] [103/133] (554s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[480.443077] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[480.445013] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[480.508442] [104/133] (553s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[480.561253] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[480.669493] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.109s)
[480.741216] [105/133] (553s left) syncobj_wait (wait-for-submit-snapshot)
[480.796447] Starting subtest: wait-for-submit-snapshot
[480.877568] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[480.960740] [106/133] (553s left) kms_pm_rpm (pm-tiling)
[482.705277] Starting subtest: pm-tiling
[482.707278] Subtest pm-tiling: SKIP (0.000s)
[483.269576] [107/133] (551s left) gem_mmap_gtt (cpuset-basic-small-copy)
[483.327159] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[483.384684] [108/133] (551s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[483.482089] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[487.137063] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.677s)
[488.254477] [109/133] (546s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[488.307886] Starting subtest: single-wait-all-for-submit-available-submitted
[488.308797] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[488.400988] [110/133] (546s left) kms_rotation_crc (primary-rotation-180)
[488.496593] Starting subtest: primary-rotation-180
[495.519708] Subtest primary-rotation-180: SUCCESS (7.044s)
[496.695765] [111/133] (538s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[496.788625] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[496.790251] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[496.896235] [112/133] (537s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[496.981642] Starting subtest: primary-4-tiled-reflect-x-0
[503.908848] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.937s)
[505.060170] [113/133] (529s left) kms_plane_lowres (tiling-x)
[505.156477] Starting subtest: tiling-x
[505.157317] Starting dynamic subtest: pipe-A-eDP-1
[505.158982] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[505.454182] Starting dynamic subtest: pipe-B-eDP-1
[505.455754] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[505.464390] Starting dynamic subtest: pipe-C-eDP-1
[505.465919] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[505.475292] Starting dynamic subtest: pipe-D-eDP-1
[505.476909] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[505.478682] Subtest tiling-x: SKIP (0.297s)
[506.290537] [114/133] (528s left) kms_lease (lease-revoke)
[506.384629] Starting subtest: lease-revoke
[506.385447] Starting dynamic subtest: pipe-A-eDP-1
[506.414484] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.029s)
[506.428744] Starting dynamic subtest: pipe-B-eDP-1
[506.444841] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.030s)
[506.456299] Starting dynamic subtest: pipe-C-eDP-1
[506.473483] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[506.486014] Starting dynamic subtest: pipe-D-eDP-1
[506.501799] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[506.502736] Subtest lease-revoke: SUCCESS (0.119s)
[506.626999] [115/133] (528s left) kms_hdr (static-toggle-dpms)
[506.715974] Starting subtest: static-toggle-dpms
[506.718762] Subtest static-toggle-dpms: SKIP (0.000s)
[506.800332] [116/133] (528s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[506.884467] Starting subtest: primary-yf-tiled-reflect-x-270
[506.886762] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[506.963517] [117/133] (528s left) gem_ccs (block-copy-uncompressed)
[507.019399] Starting subtest: block-copy-uncompressed
[507.020258] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[507.041605] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[507.052166] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[507.059643] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[507.068390] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[507.076465] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[507.087193] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[507.093861] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[507.094667] Subtest block-copy-uncompressed: SUCCESS (0.075s)
[507.220775] [118/133] (527s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[507.298907] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[507.299895] Starting dynamic subtest: pipe-A-eDP-1
[507.308613] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[507.322568] Starting dynamic subtest: pipe-B-eDP-1
[507.331365] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[507.345054] Starting dynamic subtest: pipe-C-eDP-1
[507.352539] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[507.361654] Starting dynamic subtest: pipe-D-eDP-1
[507.370004] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[507.371651] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[509.553011] [119/133] (525s left) vgem_basic (setversion)
[509.591819] Starting subtest: setversion
[509.593725] Subtest setversion: SUCCESS (0.000s)
[509.659395] [120/133] (525s left) api_intel_bb (purge-bb)
[509.704860] Starting subtest: purge-bb
[509.707255] Subtest purge-bb: SUCCESS (0.003s)
[509.831737] [121/133] (525s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[509.932722] Starting subtest: cursorB-vs-flipA-toggle
[509.935585] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[510.086202] [122/133] (525s left) kms_draw_crc (draw-method-pwrite)
[510.168792] Starting subtest: draw-method-pwrite
[510.169801] Starting dynamic subtest: xrgb8888-untiled
[510.780220] Dynamic subtest xrgb8888-untiled: SUCCESS (0.611s)
[510.789729] Starting dynamic subtest: rgb565-untiled
[511.258380] Dynamic subtest rgb565-untiled: SUCCESS (0.477s)
[511.267622] Starting dynamic subtest: xrgb2101010-untiled
[511.858835] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.599s)
[511.869743] Starting dynamic subtest: xbgr16161616f-untiled
[512.692242] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.831s)
[512.703404] Starting dynamic subtest: xrgb8888-xtiled
[514.638094] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.944s)
[514.649196] Starting dynamic subtest: rgb565-xtiled
[515.826772] Dynamic subtest rgb565-xtiled: SUCCESS (1.186s)
[515.841879] Starting dynamic subtest: xrgb2101010-xtiled
[517.760777] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.932s)
[517.770263] Starting dynamic subtest: xbgr16161616f-xtiled
[521.417184] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.655s)
[521.427071] Starting dynamic subtest: xrgb8888-4tiled
[522.606196] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.188s)
[522.619918] Starting dynamic subtest: rgb565-4tiled
[523.206371] Dynamic subtest rgb565-4tiled: SUCCESS (0.599s)
[523.216776] Starting dynamic subtest: xrgb2101010-4tiled
[524.395114] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.186s)
[524.404659] Starting dynamic subtest: xbgr16161616f-4tiled
[527.661946] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.266s)
[527.662838] Subtest draw-method-pwrite: SUCCESS (17.490s)
[527.764013] [123/133] (507s left) kms_flip (dpms-off-confusion-interruptible)
[527.863529] Starting subtest: dpms-off-confusion-interruptible
[527.865799] Starting dynamic subtest: A-eDP1
[536.606484] Dynamic subtest A-eDP1: SUCCESS (8.715s)
[536.617348] Starting dynamic subtest: B-eDP1
[545.225473] Dynamic subtest B-eDP1: SUCCESS (8.616s)
[545.235667] Starting dynamic subtest: C-eDP1
[553.841907] Dynamic subtest C-eDP1: SUCCESS (8.607s)
[553.853175] Starting dynamic subtest: D-eDP1
[562.470997] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[562.472096] Subtest dpms-off-confusion-interruptible: SUCCESS (34.580s)
[563.583616] [124/133] (471s left) kms_atomic (atomic-invalid-params)
[563.686529] Starting subtest: atomic-invalid-params
[563.687458] Starting dynamic subtest: pipe-A-eDP-1
[564.088161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[564.089115] Subtest atomic-invalid-params: SUCCESS (0.402s)
[564.913875] [125/133] (470s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[564.986730] Starting subtest: map-fixed-invalidate-overlap-busy
[564.988671] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[565.119599] [126/133] (470s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[565.212459] Starting subtest: plane-all-modeset-transition-fencing
[565.214289] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[565.287041] [127/133] (470s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[565.371573] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[565.373234] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[565.442623] [128/133] (469s left) gem_exec_balancer (bonded-false-hang)
[565.718349] Starting subtest: bonded-false-hang
[565.720847] Subtest bonded-false-hang: SKIP (0.000s)
[565.815278] [129/133] (469s left) kms_chamelium_edid (hdmi-edid-read)
[566.198198] Subtest hdmi-edid-read: SKIP (0.000s)
[567.030208] [130/133] (468s left) gem_tiled_partial_pwrite_pread (reads)
[567.097529] Subtest reads: SKIP (0.000s)
[567.170247] [131/133] (468s left) kms_big_fb (linear-32bpp-rotate-180)
[567.267820] Starting subtest: linear-32bpp-rotate-180
[568.837484] Subtest linear-32bpp-rotate-180: SUCCESS (1.570s)
[568.995216] [132/133] (466s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[569.564900] Starting subtest: syncobj-timeline-invalid-flags
[569.565992] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[570.662324] [133/133] (464s left) gem_ppgtt (shrink-vs-evict-pinned)
[570.707774] Starting subtest: shrink-vs-evict-pinned
[576.667754] Subtest shrink-vs-evict-pinned: SUCCESS (5.912s)
[576.701612] 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.