[54.830924] Initializing watchdogs
[54.830970]   /dev/watchdog0
[54.845215] [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]
[54.849481] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.851538] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.854620] [001/130] (960s left) gem_softpin (evict-active-interruptible)
[54.926349] Starting subtest: evict-active-interruptible
[54.932998] Subtest evict-active-interruptible: SUCCESS (0.007s)
[55.044585] [002/130] (960s left) kms_plane_scaling (planes-downscale-factor-0-5)
[55.143818] Starting subtest: planes-downscale-factor-0-5
[55.146111] Starting dynamic subtest: pipe-A
[55.155219] Dynamic subtest pipe-A: SKIP (0.006s)
[55.162247] Starting dynamic subtest: pipe-B
[55.177421] Dynamic subtest pipe-B: SKIP (0.022s)
[55.184220] Starting dynamic subtest: pipe-C
[55.201392] Dynamic subtest pipe-C: SKIP (0.024s)
[55.207838] Starting dynamic subtest: pipe-D
[55.225616] Dynamic subtest pipe-D: SKIP (0.023s)
[55.230143] Subtest planes-downscale-factor-0-5: SKIP (0.075s)
[55.312246] [003/130] (960s left) i915_pm_rps (waitboost)
[55.367207] Starting subtest: waitboost
[55.433666] Subtest waitboost: FAIL (0.025s)
[55.496312] [004/130] (959s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[55.604652] Starting subtest: stress-xrgb8888-yftiled
[55.608719] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[55.671132] [005/130] (959s left) gem_lmem_swapping (heavy-verify-random-ccs)
[55.712152] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[55.752490] [006/130] (959s left) syncobj_eventfd (timeline-wait)
[55.800404] Starting subtest: timeline-wait
[55.809248] Subtest timeline-wait: SUCCESS (0.010s)
[55.914461] [007/130] (959s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[56.011592] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[56.013680] Starting dynamic subtest: pipe-A-eDP-1
[56.035532] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[56.045497] Starting dynamic subtest: pipe-B-eDP-1
[56.065417] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[56.071144] Starting dynamic subtest: pipe-C-eDP-1
[56.091248] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[56.096999] Starting dynamic subtest: pipe-D-eDP-1
[56.117073] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[56.120706] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.002s)
[58.212599] [008/130] (957s left) gem_pread (snoop)
[58.270651] Subtest snoop: SKIP (0.000s)
[58.335056] [009/130] (957s left) kms_pm_lpsp (kms-lpsp)
[59.437739] Starting subtest: kms-lpsp
[59.440104] Starting dynamic subtest: pipe-A-eDP-1
[59.621869] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.186s)
[59.908308] Subtest kms-lpsp: SUCCESS (0.468s)
[60.754034] [010/130] (954s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[60.861045] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[61.943238] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.078s)
[62.139966] [011/130] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[62.242781] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[62.247334] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.343736] [012/130] (953s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[62.469204] Starting subtest: flip-vs-cursor-toggle
[70.572497] Subtest flip-vs-cursor-toggle: SUCCESS (8.080s)
[71.416164] [013/130] (944s left) kms_psr (pr-primary-mmap-gtt)
[71.636661] Starting subtest: pr-primary-mmap-gtt
[71.641898] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[71.853999] [014/130] (943s left) perf (enable-disable)
[71.994433] Starting subtest: enable-disable
[71.996796] Starting dynamic subtest: 0-rcs0
[74.249656] Dynamic subtest 0-rcs0: SUCCESS (2.252s)
[74.257022] Starting dynamic subtest: 1-vcs1
[78.690043] Dynamic subtest 1-vcs1: SUCCESS (4.436s)
[78.692354] Subtest enable-disable: SUCCESS (6.688s)
[78.733399] [015/130] (937s left) kms_frontbuffer_tracking (psr-1p-rte)
[78.842139] Starting subtest: psr-1p-rte
[84.178539] Subtest psr-1p-rte: SUCCESS (5.339s)
[84.331609] [016/130] (931s left) kms_psr (fbc-psr2-sprite-blt)
[84.433076] Starting subtest: fbc-psr2-sprite-blt
[84.435220] Starting dynamic subtest: eDP-1
[84.439138] Dynamic subtest eDP-1: SKIP (0.000s)
[84.443054] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[84.505221] [017/130] (931s left) gem_exec_params (invalid-bsd2-flag-on-render)
[84.561679] Starting subtest: invalid-bsd2-flag-on-render
[84.564022] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[84.669197] [018/130] (931s left) kms_chamelium_edid (hdmi-edid-read)
[85.041396] Subtest hdmi-edid-read: SKIP (0.000s)
[85.802104] [019/130] (930s left) gem_spin_batch (spin-all)
[85.861460] Starting subtest: spin-all
[85.874576] Subtest spin-all: SUCCESS (0.012s)
[87.927632] [020/130] (928s left) gem_exec_alignment (many)
[87.977847] Starting subtest: many
[109.986609] Subtest many: SUCCESS (22.003s)
[111.675307] [021/130] (904s left) kms_cursor_crc (cursor-onscreen-max-size)
[112.024779] Starting subtest: cursor-onscreen-max-size
[112.031521] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[112.188218] [022/130] (903s left) kms_content_protection (content-type-change)
[112.358615] Starting subtest: content-type-change
[115.768076] Subtest content-type-change: SKIP (3.407s)
[116.937184] [023/130] (899s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[117.047830] Starting subtest: 4-tiled-64bpp-rotate-0
[119.302144] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (2.256s)
[119.800787] [024/130] (896s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[124.780754] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[124.783316] Starting dynamic subtest: pipe-A-eDP-1
[125.595273] Dynamic subtest pipe-A-eDP-1: SKIP (0.809s)
[125.604738] Starting dynamic subtest: pipe-B-eDP-1
[126.715188] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[126.719798] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.931s)
[127.884627] [025/130] (888s left) kms_atomic_interruptible (universal-setplane-primary)
[127.990657] Starting subtest: universal-setplane-primary
[127.992971] Starting dynamic subtest: pipe-A-eDP-1
[135.412137] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.417s)
[135.414572] Subtest universal-setplane-primary: SUCCESS (7.417s)
[136.236289] [026/130] (880s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[136.355266] Starting subtest: yf-tiled-16bpp-rotate-90
[136.359715] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[136.459390] [027/130] (879s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[136.572518] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[141.133768] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.566s)
[142.219707] [028/130] (874s left) gem_exec_balancer (full-pulse)
[142.280869] Starting subtest: full-pulse
[146.766881] Subtest full-pulse: SUCCESS (4.485s)
[147.075023] [029/130] (869s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[147.137564] Starting subtest: invalid-multi-wait-unsubmitted
[147.139521] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[147.236836] [030/130] (869s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[147.341325] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[147.345442] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[147.462075] [031/130] (868s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[147.515782] Starting subtest: multi-wait-available-unsubmitted-submitted
[147.517919] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[147.627814] [032/130] (868s left) gem_mmap_gtt (big-bo-tiledy)
[147.687209] Subtest big-bo-tiledY: SKIP (0.000s)
[147.748395] [033/130] (868s left) gem_mmap_wc (fault-concurrent)
[147.807081] Subtest fault-concurrent: SKIP (0.000s)
[147.861828] [034/130] (868s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[148.159106] Starting subtest: cursor-rapid-movement-max-size
[148.164900] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[148.290391] [035/130] (868s left) testdisplay
[148.653868] [036/130] (867s left) gem_mmap (bad-size)
[148.716540] Subtest bad-size: SKIP (0.000s)
[148.778929] [037/130] (867s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[148.885284] Starting subtest: x-tiled-64bpp-rotate-270
[148.904158] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[149.040132] [038/130] (867s left) kms_dsc (dsc-with-output-formats)
[149.135606] Starting subtest: dsc-with-output-formats
[149.153355] Subtest dsc-with-output-formats: SKIP (0.000s)
[149.201702] [039/130] (867s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[149.292711] Starting subtest: flip-vs-dpms-off-vs-modeset
[149.294835] Starting dynamic subtest: A-eDP1
[152.907662] Dynamic subtest A-eDP1: SUCCESS (3.612s)
[152.916574] Starting dynamic subtest: B-eDP1
[156.083951] Dynamic subtest B-eDP1: SUCCESS (3.177s)
[156.094426] Starting dynamic subtest: C-eDP1
[159.179472] Dynamic subtest C-eDP1: SUCCESS (3.094s)
[159.188834] Starting dynamic subtest: D-eDP1
[162.250435] Dynamic subtest D-eDP1: SUCCESS (3.068s)
[162.252538] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.957s)
[163.038571] [040/130] (853s left) gem_softpin (invalid)
[163.097688] Starting subtest: invalid
[163.104843] Subtest invalid: SUCCESS (0.006s)
[163.231756] [041/130] (853s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[163.337904] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[163.342158] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[163.438306] [042/130] (853s left) gem_exec_params (batch-first)
[163.504869] Starting subtest: batch-first
[163.511222] Subtest batch-first: SUCCESS (0.006s)
[163.629754] [043/130] (853s left) gem_exec_reloc (basic-range)
[163.693788] Subtest basic-range: SKIP (0.000s)
[163.764555] [044/130] (853s left) gem_exec_schedule (timeslicing)
[163.836547] Starting subtest: timeslicing
[163.838743] Starting dynamic subtest: rcs0
[163.851178] Dynamic subtest rcs0: SUCCESS (0.021s)
[163.859193] Starting dynamic subtest: bcs0
[163.871346] Dynamic subtest bcs0: SUCCESS (0.020s)
[163.879424] Starting dynamic subtest: vcs0
[163.892314] Dynamic subtest vcs0: SUCCESS (0.021s)
[163.899934] Starting dynamic subtest: vcs1
[163.911344] Dynamic subtest vcs1: SUCCESS (0.019s)
[163.919124] Starting dynamic subtest: vecs0
[163.930899] Dynamic subtest vecs0: SUCCESS (0.019s)
[163.938777] Starting dynamic subtest: ccs0
[163.950069] Dynamic subtest ccs0: SUCCESS (0.019s)
[163.952356] Subtest timeslicing: SUCCESS (0.120s)
[165.945382] [045/130] (851s left) prime_vgem (fence-read-hang)
[166.136365] Subtest fence-read-hang: SKIP (0.000s)
[166.215177] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[166.218273] [046/130] (850s left) gem_ppgtt (shrink-vs-evict-pinned)
[166.282952] Starting subtest: shrink-vs-evict-pinned
[171.888081] Subtest shrink-vs-evict-pinned: SUCCESS (5.601s)
[171.988820] [047/130] (845s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[172.093157] Starting subtest: plane-upscale-20x20-with-modifiers
[172.095409] Starting dynamic subtest: pipe-A
[172.431632] Dynamic subtest pipe-A: SUCCESS (0.338s)
[172.445674] Starting dynamic subtest: pipe-B
[173.832099] Dynamic subtest pipe-B: SUCCESS (1.400s)
[173.839896] Starting dynamic subtest: pipe-C
[175.258186] Dynamic subtest pipe-C: SUCCESS (1.425s)
[175.267107] Starting dynamic subtest: pipe-D
[176.681181] Dynamic subtest pipe-D: SUCCESS (1.422s)
[176.683350] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.588s)
[177.838114] [048/130] (839s left) kms_atomic (plane-overlay-legacy)
[177.940129] Starting subtest: plane-overlay-legacy
[177.942420] Starting dynamic subtest: pipe-A-eDP-1
[178.356411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.414s)
[178.358785] Subtest plane-overlay-legacy: SUCCESS (0.415s)
[179.164597] [049/130] (837s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[179.260619] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[186.488525] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.232s)
[186.636400] [050/130] (830s left) kms_dp_link_training (uhbr-sst)
[186.728925] Starting subtest: uhbr-sst
[186.737745] Subtest uhbr-sst: SKIP (0.000s)
[186.801556] [051/130] (830s left) gem_exec_fence (basic-await)
[186.980657] Starting subtest: basic-await
[186.983122] Starting dynamic subtest: rcs0
[187.053569] Dynamic subtest rcs0: SUCCESS (0.073s)
[187.064384] Starting dynamic subtest: bcs0
[187.127805] Dynamic subtest bcs0: SUCCESS (0.073s)
[187.139299] Starting dynamic subtest: vcs0
[187.197761] Dynamic subtest vcs0: SUCCESS (0.070s)
[187.208388] Starting dynamic subtest: vcs1
[187.268827] Dynamic subtest vcs1: SUCCESS (0.070s)
[187.280234] Starting dynamic subtest: vecs0
[187.340300] Dynamic subtest vecs0: SUCCESS (0.071s)
[187.351937] Starting dynamic subtest: ccs0
[187.412314] Dynamic subtest ccs0: SUCCESS (0.070s)
[187.414960] Subtest basic-await: SUCCESS (0.432s)
[189.001250] [052/130] (828s left) gem_close (many-handles-one-vma)
[189.061959] Starting subtest: many-handles-one-vma
[189.083630] Subtest many-handles-one-vma: SUCCESS (0.022s)
[189.174850] [053/130] (828s left) syncobj_wait (wait-any-complex)
[189.237808] Starting subtest: wait-any-complex
[189.298754] Subtest wait-any-complex: SUCCESS (0.061s)
[189.377555] [054/130] (827s left) i915_selftest (perf)
[191.205799] Starting subtest: perf
[191.208760] Starting dynamic subtest: engine_cs
[195.664586] Dynamic subtest engine_cs: SUCCESS (4.458s)
[195.672847] Starting dynamic subtest: request
[201.065938] Dynamic subtest request: SUCCESS (5.400s)
[201.074717] Starting dynamic subtest: migrate
[205.414294] Dynamic subtest migrate: SUCCESS (4.346s)
[205.423671] Starting dynamic subtest: region
[209.752305] Dynamic subtest region: SUCCESS (4.337s)
[209.754820] Subtest perf: SUCCESS (18.546s)
[209.784608] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[209.785301] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[209.788343] [055/130] (807s left) fbdev (nullptr)
[211.200267] Starting subtest: nullptr
[211.202604] Subtest nullptr: SUCCESS (0.000s)
[211.235598] [FACT fbdev (nullptr)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[211.238643] [FACT fbdev (nullptr)] new: kernel.kmod_is_loaded.i915: true
[211.242805] [056/130] (806s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[211.359064] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[211.363396] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[211.475953] [057/130] (805s left) perf_pmu (busy-start)
[211.515035] Starting subtest: busy-start
[211.517370] Starting dynamic subtest: rcs0
[214.070938] Dynamic subtest rcs0: SUCCESS (2.556s)
[214.079288] Starting dynamic subtest: bcs0
[216.619480] Dynamic subtest bcs0: SUCCESS (2.546s)
[216.629967] Starting dynamic subtest: vcs0
[219.926684] Dynamic subtest vcs0: SUCCESS (3.304s)
[219.935502] Starting dynamic subtest: vcs1
[223.892681] Dynamic subtest vcs1: SUCCESS (3.964s)
[223.901685] Starting dynamic subtest: vecs0
[227.924474] Dynamic subtest vecs0: SUCCESS (4.029s)
[227.935767] Starting dynamic subtest: ccs0
[230.476284] Dynamic subtest ccs0: SUCCESS (2.552s)
[230.479161] Subtest busy-start: SUCCESS (18.961s)
[230.595764] [058/130] (786s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[230.645810] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[230.753357] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[230.827804] [059/130] (786s left) perf_pmu (render-node-busy-idle)
[230.906058] Starting subtest: render-node-busy-idle
[230.908850] Starting dynamic subtest: rcs0
[231.604622] Dynamic subtest rcs0: SUCCESS (0.698s)
[231.615932] Starting dynamic subtest: bcs0
[232.281275] Dynamic subtest bcs0: SUCCESS (0.675s)
[232.291402] Starting dynamic subtest: vcs0
[233.942422] Dynamic subtest vcs0: SUCCESS (1.658s)
[233.951840] Starting dynamic subtest: vcs1
[235.924469] Dynamic subtest vcs1: SUCCESS (1.981s)
[235.935027] Starting dynamic subtest: vecs0
[237.910384] Dynamic subtest vecs0: SUCCESS (1.984s)
[237.921266] Starting dynamic subtest: ccs0
[238.588162] Dynamic subtest ccs0: SUCCESS (0.677s)
[238.590638] Subtest render-node-busy-idle: SUCCESS (7.682s)
[238.661348] [060/130] (778s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[238.775912] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[238.780355] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[238.888404] [061/130] (778s left) gem_ctx_isolation (dirty-switch)
[238.952655] Starting subtest: dirty-switch
[238.955099] Starting dynamic subtest: rcs0
[239.402519] Dynamic subtest rcs0: SUCCESS (0.449s)
[239.411552] Starting dynamic subtest: bcs0
[239.867256] Dynamic subtest bcs0: SUCCESS (0.465s)
[239.875579] Starting dynamic subtest: vcs0
[240.353859] Dynamic subtest vcs0: SUCCESS (0.486s)
[240.364916] Starting dynamic subtest: vcs1
[242.418493] Dynamic subtest vcs1: SUCCESS (2.064s)
[242.426466] Starting dynamic subtest: vecs0
[244.372195] Dynamic subtest vecs0: SUCCESS (1.953s)
[244.380578] Starting dynamic subtest: ccs0
[246.406568] Dynamic subtest ccs0: SUCCESS (2.033s)
[246.409291] Subtest dirty-switch: SUCCESS (7.454s)
[246.673765] [062/130] (770s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[246.771886] Starting subtest: crc-primary-suspend-y-tiled-ccs
[246.774202] Starting dynamic subtest: pipe-A-eDP-1
[246.783834] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.791865] Starting dynamic subtest: pipe-B-eDP-1
[246.801204] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.810385] Starting dynamic subtest: pipe-C-eDP-1
[246.819300] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.827156] Starting dynamic subtest: pipe-D-eDP-1
[246.835585] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.839759] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[248.953722] [063/130] (768s left) prime_vgem (basic-fence-read)
[249.036478] Starting subtest: basic-fence-read
[249.046048] Subtest basic-fence-read: SKIP (0.007s)
[249.143243] [064/130] (768s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[249.232750] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[249.235077] Starting dynamic subtest: pipe-A-eDP-1
[249.257817] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[249.267385] Starting dynamic subtest: pipe-B-eDP-1
[249.288729] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[249.296074] Starting dynamic subtest: pipe-C-eDP-1
[249.317719] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[249.325209] Starting dynamic subtest: pipe-D-eDP-1
[249.347016] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[249.351374] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[251.496314] [065/130] (766s left) kms_psr (psr-primary-page-flip)
[251.598852] Starting subtest: psr-primary-page-flip
[251.601345] Starting dynamic subtest: eDP-1
[253.394550] Dynamic subtest eDP-1: SUCCESS (1.795s)
[253.396890] Subtest psr-primary-page-flip: SUCCESS (1.796s)
[254.251856] [066/130] (763s left) gem_exec_schedule (independent)
[254.323080] Starting subtest: independent
[254.325135] Starting dynamic subtest: rcs0
[255.897467] Dynamic subtest rcs0: SUCCESS (1.585s)
[255.908962] Starting dynamic subtest: vcs0
[257.964063] Dynamic subtest vcs0: SUCCESS (2.065s)
[257.975430] Starting dynamic subtest: vcs1
[259.967491] Dynamic subtest vcs1: SUCCESS (2.001s)
[259.978852] Starting dynamic subtest: vecs0
[261.958600] Dynamic subtest vecs0: SUCCESS (1.989s)
[261.971189] Starting dynamic subtest: ccs0
[263.892459] Dynamic subtest ccs0: SUCCESS (1.932s)
[263.895073] Subtest independent: SUCCESS (9.581s)
[264.185329] [067/130] (753s left) gem_exec_parallel (userptr)
[264.244401] Starting subtest: userptr
[264.246810] Starting dynamic subtest: rcs0
[265.777918] Dynamic subtest rcs0: SUCCESS (1.532s)
[265.789251] Starting dynamic subtest: bcs0
[267.298575] Dynamic subtest bcs0: SUCCESS (1.519s)
[267.309148] Starting dynamic subtest: vcs0
[268.906075] Dynamic subtest vcs0: SUCCESS (1.605s)
[268.914740] Starting dynamic subtest: vcs1
[270.932450] Dynamic subtest vcs1: SUCCESS (2.024s)
[270.943438] Starting dynamic subtest: vecs0
[272.854681] Dynamic subtest vecs0: SUCCESS (1.920s)
[272.865816] Starting dynamic subtest: ccs0
[274.356090] Dynamic subtest ccs0: SUCCESS (1.500s)
[274.358966] Subtest userptr: SUCCESS (10.112s)
[274.544258] [068/130] (743s left) gem_ringfill (legacy-basic)
[279.897573] Starting subtest: legacy-basic
[279.900227] Starting dynamic subtest: default
[279.964324] Dynamic subtest default: SUCCESS (0.067s)
[279.976407] Starting dynamic subtest: render
[280.006914] Dynamic subtest render: SUCCESS (0.041s)
[280.017576] Starting dynamic subtest: bsd
[280.050960] Dynamic subtest bsd: SUCCESS (0.042s)
[280.060913] Starting dynamic subtest: bsd1
[280.091791] Dynamic subtest bsd1: SUCCESS (0.039s)
[280.101131] Starting dynamic subtest: bsd2
[280.134050] Dynamic subtest bsd2: SUCCESS (0.040s)
[280.143904] Starting dynamic subtest: blt
[280.177665] Dynamic subtest blt: SUCCESS (0.042s)
[280.187322] Starting dynamic subtest: vebox
[280.218807] Dynamic subtest vebox: SUCCESS (0.039s)
[280.221218] Subtest legacy-basic: SUCCESS (0.324s)
[280.295299] [069/130] (737s left) gem_exec_whisper (basic-queues)
[280.361366] Starting subtest: basic-queues
[288.888947] Subtest basic-queues: SUCCESS (8.524s)
[289.067658] [070/130] (728s left) syncobj_timeline (invalid-transfer-non-existent-point)
[289.115133] Starting subtest: invalid-transfer-non-existent-point
[289.117632] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[289.226370] [071/130] (728s left) core_getstats
[289.399379] [072/130] (728s left) gem_eio (in-flight-suspend)
[289.640950] Starting subtest: in-flight-suspend
[331.978834] Subtest in-flight-suspend: SUCCESS (13.255s)
[332.125156] [073/130] (685s left) kms_flip (2x-flip-vs-expired-vblank)
[332.229858] Starting subtest: 2x-flip-vs-expired-vblank
[332.240470] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[332.318288] [074/130] (685s left) kms_chamelium_hpd (dp-hpd-fast)
[332.700774] Subtest dp-hpd-fast: SKIP (0.000s)
[333.579527] [075/130] (684s left) gem_readwrite (read-write)
[333.630585] Subtest read-write: SKIP (0.000s)
[333.691537] [076/130] (684s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[333.780862] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[333.783158] Starting dynamic subtest: pipe-A-eDP-1
[333.806713] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[333.818822] Starting dynamic subtest: pipe-B-eDP-1
[333.841192] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[333.853725] Starting dynamic subtest: pipe-C-eDP-1
[333.881894] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[333.891076] Starting dynamic subtest: pipe-D-eDP-1
[333.912730] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[333.916955] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[335.955219] [077/130] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[336.060297] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[336.064317] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[336.159281] [078/130] (682s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[336.258712] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[336.262775] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[336.371717] [079/130] (681s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[336.485816] Starting subtest: short-flip-after-cursor-toggle
[337.419367] Subtest short-flip-after-cursor-toggle: SUCCESS (0.925s)
[338.309211] [080/130] (680s left) gem_exec_await (wide-all)
[338.492157] Starting subtest: wide-all
[361.831886] Subtest wide-all: SUCCESS (23.267s)
[362.043493] [081/130] (656s left) gem_userptr_blits (coherency-unsync)
[362.142226] Subtest coherency-unsync: SKIP (0.000s)
[362.275486] [082/130] (656s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[362.391304] Starting subtest: fbc-rgb101010-draw-pwrite
[367.774809] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.387s)
[368.964217] [083/130] (649s left) gem_ctx_persistence (idempotent)
[369.030672] Starting subtest: idempotent
[369.033084] Subtest idempotent: SUCCESS (0.000s)
[369.140365] [084/130] (649s left) kms_scaling_modes (scaling-mode-full)
[369.226788] Starting subtest: scaling-mode-full
[369.228990] Starting dynamic subtest: pipe-A-eDP-1
[369.348392] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.121s)
[369.361750] Starting dynamic subtest: pipe-B-eDP-1
[370.573407] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.222s)
[370.585824] Starting dynamic subtest: pipe-C-eDP-1
[371.779079] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[371.789186] Starting dynamic subtest: pipe-D-eDP-1
[372.998332] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s)
[373.000669] Subtest scaling-mode-full: SUCCESS (3.772s)
[374.149061] [085/130] (644s left) vgem_basic (sysfs)
[374.209906] Starting subtest: sysfs
[374.212213] Subtest sysfs: SUCCESS (0.001s)
[374.264472] [086/130] (644s left) i915_drm_fdinfo (virtual-busy)
[374.306545] Starting subtest: virtual-busy
[374.311459] Subtest virtual-busy: SKIP (0.000s)
[374.366967] [087/130] (644s left) kms_vblank (wait-busy)
[374.465761] Starting subtest: wait-busy
[374.467969] Starting dynamic subtest: pipe-A-eDP-1
[376.352427] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[376.369512] Starting dynamic subtest: pipe-D-eDP-1
[378.908781] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.552s)
[378.910806] Subtest wait-busy: SUCCESS (4.440s)
[379.705882] [088/130] (639s left) api_intel_bb (reset-flags)
[379.760777] Starting subtest: reset-flags
[379.769020] Subtest reset-flags: SUCCESS (0.009s)
[379.886790] [089/130] (638s left) kms_flip (busy-flip)
[379.977849] Starting subtest: busy-flip
[379.980193] Starting dynamic subtest: A-eDP1
[381.705611] Dynamic subtest A-eDP1: SUCCESS (1.727s)
[381.717442] Starting dynamic subtest: B-eDP1
[383.431764] Dynamic subtest B-eDP1: SUCCESS (1.725s)
[383.443968] Starting dynamic subtest: C-eDP1
[385.137748] Dynamic subtest C-eDP1: SUCCESS (1.704s)
[385.148419] Starting dynamic subtest: D-eDP1
[386.856569] Dynamic subtest D-eDP1: SUCCESS (1.718s)
[386.863211] Subtest busy-flip: SUCCESS (6.882s)
[388.002657] [090/130] (630s left) kms_lease (lease-revoke)
[388.105323] Starting subtest: lease-revoke
[388.107659] Starting dynamic subtest: pipe-A-eDP-1
[388.148329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.041s)
[388.161012] Starting dynamic subtest: pipe-B-eDP-1
[388.194630] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.046s)
[388.206010] Starting dynamic subtest: pipe-C-eDP-1
[388.234555] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.039s)
[388.244798] Starting dynamic subtest: pipe-D-eDP-1
[388.272306] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.037s)
[388.274694] Subtest lease-revoke: SUCCESS (0.167s)
[388.410567] [091/130] (630s left) prime_busy (after-wait)
[388.464944] Starting subtest: after-wait
[388.469683] Starting dynamic subtest: rcs0
[388.512120] Dynamic subtest rcs0: SUCCESS (0.044s)
[388.523218] Starting dynamic subtest: bcs0
[388.573370] Dynamic subtest bcs0: SUCCESS (0.060s)
[388.584001] Starting dynamic subtest: vcs0
[388.612928] Dynamic subtest vcs0: SUCCESS (0.039s)
[388.622325] Starting dynamic subtest: vcs1
[388.654354] Dynamic subtest vcs1: SUCCESS (0.041s)
[388.664553] Starting dynamic subtest: vecs0
[388.693998] Dynamic subtest vecs0: SUCCESS (0.039s)
[388.703695] Starting dynamic subtest: ccs0
[388.735764] Dynamic subtest ccs0: SUCCESS (0.041s)
[388.843066] Subtest after-wait: SUCCESS (0.376s)
[388.916427] [092/130] (629s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[389.012944] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[389.015267] Starting dynamic subtest: pipe-A-eDP-1
[389.157889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[389.169022] Starting dynamic subtest: pipe-B-eDP-1
[389.304518] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.146s)
[389.314489] Starting dynamic subtest: pipe-C-eDP-1
[389.450676] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.145s)
[389.461263] Starting dynamic subtest: pipe-D-eDP-1
[389.599380] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.148s)
[389.601772] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.587s)
[391.765559] [093/130] (627s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[391.882501] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[391.887413] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[392.029607] [094/130] (626s left) gem_softpin (evict-snoop-interruptible)
[392.087147] Starting subtest: evict-snoop-interruptible
[392.091887] Subtest evict-snoop-interruptible: SKIP (0.000s)
[392.220209] [095/130] (626s left) api_intel_allocator (reopen)
[392.267889] Starting subtest: reopen
[392.272585] Subtest reopen: SUCCESS (0.004s)
[392.394341] [096/130] (626s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[392.453953] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[392.458691] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[392.639561] [097/130] (626s left) kms_vblank (query-forked-hang)
[392.729670] Starting subtest: query-forked-hang
[392.732005] Starting dynamic subtest: pipe-A-eDP-1
[418.733405] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.990s)
[418.751416] Starting dynamic subtest: pipe-D-eDP-1
[433.824870] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.090s)
[433.827427] Subtest query-forked-hang: SUCCESS (41.085s)
[434.606960] [098/130] (584s left) kms_frontbuffer_tracking (psr-suspend)
[434.699347] Starting subtest: psr-suspend
[472.906686] Subtest psr-suspend: SUCCESS (7.582s)
[473.055649] [099/130] (546s left) kms_prop_blob (invalid-set-prop-any)
[473.124219] Starting subtest: invalid-set-prop-any
[473.127052] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[473.233987] [100/130] (545s left) kms_plane_multiple (tiling-x)
[473.327556] Starting subtest: tiling-x
[473.330102] Starting dynamic subtest: pipe-A-eDP-1
[477.077404] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.696s)
[477.088127] Starting dynamic subtest: pipe-B-eDP-1
[481.502895] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.388s)
[481.514618] Starting dynamic subtest: pipe-C-eDP-1
[485.817414] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.292s)
[485.828283] Starting dynamic subtest: pipe-D-eDP-1
[490.146463] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.314s)
[490.148909] Subtest tiling-x: SUCCESS (16.695s)
[490.951984] [101/130] (528s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[491.062886] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[491.067764] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[491.176076] [102/130] (528s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[491.264600] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[491.267827] Starting dynamic subtest: pipe-A-default-mode
[491.548420] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[491.553612] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.285s)
[492.379452] [103/130] (526s left) gem_exec_schedule (preemptive-hang)
[492.575367] Starting subtest: preemptive-hang
[492.577926] Starting dynamic subtest: rcs0
[501.793486] Dynamic subtest rcs0: SUCCESS (9.206s)
[501.803611] Starting dynamic subtest: bcs0
[510.687716] Dynamic subtest bcs0: SUCCESS (8.892s)
[510.698856] Starting dynamic subtest: vcs0
[519.714788] Dynamic subtest vcs0: SUCCESS (9.026s)
[519.727626] Starting dynamic subtest: vcs1
[528.737307] Dynamic subtest vcs1: SUCCESS (9.017s)
[528.748143] Starting dynamic subtest: vecs0
[537.696885] Dynamic subtest vecs0: SUCCESS (8.956s)
[537.709316] Starting dynamic subtest: ccs0
[546.719596] Dynamic subtest ccs0: SUCCESS (9.017s)
[546.722772] Subtest preemptive-hang: SUCCESS (54.125s)
[546.983454] [104/130] (472s left) i915_drm_fdinfo (busy-check-all)
[547.022630] Starting subtest: busy-check-all
[547.024811] Starting dynamic subtest: rcs0
[547.031596] Dynamic subtest rcs0: SKIP (0.007s)
[547.041943] Starting dynamic subtest: bcs0
[547.046225] Dynamic subtest bcs0: SKIP (0.000s)
[547.056243] Starting dynamic subtest: vcs0
[547.061261] Dynamic subtest vcs0: SKIP (0.000s)
[547.070599] Starting dynamic subtest: vcs1
[547.075137] Dynamic subtest vcs1: SKIP (0.000s)
[547.084530] Starting dynamic subtest: vecs0
[547.089212] Dynamic subtest vecs0: SKIP (0.000s)
[547.098759] Starting dynamic subtest: ccs0
[547.103716] Dynamic subtest ccs0: SKIP (0.000s)
[547.108674] Subtest busy-check-all: SKIP (0.011s)
[547.149195] [105/130] (472s left) gen9_exec_parse (basic-rejected)
[547.219883] Subtest basic-rejected: SKIP (0.000s)
[547.286816] [106/130] (472s left) gem_exec_reloc (basic-cpu-gtt)
[547.348458] Subtest basic-cpu-gtt: SKIP (0.000s)
[547.427461] [107/130] (472s left) gem_ctx_persistence (smoketest)
[547.484824] Starting subtest: smoketest
[587.482935] Subtest smoketest: SUCCESS (39.991s)
[587.558477] [108/130] (431s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[587.659458] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[587.664581] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[587.763126] [109/130] (431s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[592.841542] Starting subtest: psr2-plane-move-sf-dmg-area
[592.843881] Starting dynamic subtest: pipe-A-eDP-1
[598.111436] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.267s)
[598.122783] Starting dynamic subtest: pipe-B-eDP-1
[603.409536] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.297s)
[603.411858] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.568s)
[604.275995] [110/130] (415s left) kms_psr (pr-primary-blt)
[604.383809] Starting subtest: pr-primary-blt
[604.388894] Subtest pr-primary-blt: SKIP (0.000s)
[604.458191] [111/130] (415s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[604.559219] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[604.561565] Starting dynamic subtest: pipe-A-default-mode
[604.845519] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[604.851070] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.286s)
[605.704098] [112/130] (413s left) gem_userptr_blits (sync-unmap-after-close)
[605.768560] Starting subtest: sync-unmap-after-close
[605.776888] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[605.922669] [113/130] (413s left) i915_pm_rpm (debugfs-read)
[607.764533] Starting subtest: debugfs-read
[608.930016] Subtest debugfs-read: SUCCESS (1.162s)
[609.275636] [114/130] (410s left) gem_exec_reloc (basic-cpu)
[609.335490] Subtest basic-cpu: SKIP (0.000s)
[609.420621] [115/130] (410s left) syncobj_timeline (wait-all-snapshot)
[609.472131] Starting subtest: wait-all-snapshot
[609.554521] Subtest wait-all-snapshot: SUCCESS (0.083s)
[609.635443] [116/130] (410s left) perf (invalid-oa-metric-set-id)
[609.756872] Starting subtest: invalid-oa-metric-set-id
[609.773408] Subtest invalid-oa-metric-set-id: SUCCESS (0.017s)
[609.814935] [117/130] (410s left) kms_hdr (static-swap)
[609.901594] Starting subtest: static-swap
[609.909362] Subtest static-swap: SKIP (0.000s)
[609.993963] [118/130] (409s left) kms_color (ctm-signed)
[610.080782] Starting subtest: ctm-signed
[610.083038] Starting dynamic subtest: pipe-A-eDP-1
[612.119556] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.041s)
[612.130757] Starting dynamic subtest: pipe-B-eDP-1
[614.914478] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.792s)
[614.925512] Starting dynamic subtest: pipe-C-eDP-1
[617.555313] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.640s)
[617.567242] Starting dynamic subtest: pipe-D-eDP-1
[620.252670] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.694s)
[620.255125] Subtest ctm-signed: SUCCESS (10.170s)
[621.055247] [119/130] (398s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[621.170526] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt
[621.175308] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[621.293136] [120/130] (398s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[621.401991] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[622.659379] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.259s)
[622.864737] [121/130] (397s left) kms_psr (fbc-pr-no-drrs)
[622.971912] Starting subtest: fbc-pr-no-drrs
[622.977713] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[623.044027] [122/130] (397s left) syncobj_wait (multi-wait-submitted)
[623.107737] Starting subtest: multi-wait-submitted
[623.214474] Subtest multi-wait-submitted: SUCCESS (0.108s)
[623.295365] [123/130] (396s left) gem_flink_race (flink_name)
[623.332305] Starting subtest: flink_name
[628.721402] Subtest flink_name: SUCCESS (5.393s)
[628.834692] [124/130] (391s left) gem_create (busy-create)
[628.906885] Starting subtest: busy-create
[628.909806] Starting dynamic subtest: smem0
[661.562904] Dynamic subtest smem0: SUCCESS (32.646s)
[661.565927] Subtest busy-create: SUCCESS (32.647s)
[661.748331] [125/130] (358s left) kms_cursor_edge_walk (64x64-left-edge)
[661.845344] Starting subtest: 64x64-left-edge
[661.847578] Starting dynamic subtest: pipe-A-eDP-1
[665.311824] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[665.323573] Starting dynamic subtest: pipe-D-eDP-1
[668.421668] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[668.424091] Subtest 64x64-left-edge: SUCCESS (6.574s)
[669.235885] [126/130] (351s left) prime_mmap (test_aperture_limit)
[669.290748] Starting subtest: test_aperture_limit
[669.293406] Starting dynamic subtest: test_aperture_limit-smem
[669.298482] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[669.303684] Subtest test_aperture_limit: SKIP (0.008s)
[669.397316] [127/130] (350s left) gem_pread (self)
[669.455283] Subtest self: SKIP (0.000s)
[669.527144] [128/130] (350s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[669.632492] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[669.637144] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[669.728791] [129/130] (350s left) gem_mmap_wc (coherency)
[669.791072] Subtest coherency: SKIP (0.000s)
[669.860887] [130/130] (350s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[669.963820] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[676.583005] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (6.621s)
[676.696789] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: i915_pm_rps
results: parsing output: 3/ for test: kms_pipe_stress
results: parsing output: 4/ for test: gem_lmem_swapping
results: parsing output: 5/ for test: syncobj_eventfd
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_pread
results: parsing output: 8/ for test: kms_pm_lpsp
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_chamelium_edid
results: parsing output: 18/ for test: gem_spin_batch
results: parsing output: 19/ for test: gem_exec_alignment
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_content_protection
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: kms_atomic_interruptible
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: testdisplay
results: parsing output: 35/ for test: gem_mmap
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_dsc
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: gem_ppgtt
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_atomic
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_dp_link_training
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: gem_close
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: i915_selftest
results: parsing output: 54/ for test: fbdev
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_ctx_isolation
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: prime_vgem
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_exec_parallel
results: parsing output: 67/ for test: gem_ringfill
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: core_getstats
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: gem_readwrite
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_exec_await
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: kms_scaling_modes
results: parsing output: 84/ for test: vgem_basic
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: api_intel_bb
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: prime_busy
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: kms_vblank
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_prop_blob
results: parsing output: 99/ for test: kms_plane_multiple
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: i915_drm_fdinfo
results: parsing output: 104/ for test: gen9_exec_parse
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: i915_pm_rpm
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_hdr
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_flink_race
results: parsing output: 123/ for test: gem_create
results: parsing output: 124/ for test: kms_cursor_edge_walk
results: parsing output: 125/ for test: prime_mmap
results: parsing output: 126/ for test: gem_pread
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_mmap_wc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
Done.