[55.351934] Initializing watchdogs
[55.352136]   /dev/watchdog0
[55.366529] [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]
[55.370832] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.373038] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.376275] [001/130] (960s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[55.458199] Starting subtest: y-tiled-to-vebox-y-tiled
[55.462772] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[55.634582] [002/130] (960s left) gem_exec_reloc (basic-cpu-read)
[55.708037] Subtest basic-cpu-read: SKIP (0.000s)
[55.776961] [003/130] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[55.873508] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[60.092694] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.223s)
[61.211623] [004/130] (954s left) gem_exec_schedule (noreorder-corked)
[61.386039] Starting subtest: noreorder-corked
[61.388549] Starting dynamic subtest: rcs0
[62.552807] Dynamic subtest rcs0: SUCCESS (1.168s)
[62.562618] Starting dynamic subtest: vcs0
[63.910389] Dynamic subtest vcs0: SUCCESS (1.356s)
[63.917714] Starting dynamic subtest: vcs1
[65.963033] Dynamic subtest vcs1: SUCCESS (2.052s)
[65.975691] Starting dynamic subtest: vecs0
[67.896802] Dynamic subtest vecs0: SUCCESS (1.934s)
[67.906946] Starting dynamic subtest: ccs0
[69.067843] Dynamic subtest ccs0: SUCCESS (1.172s)
[69.070799] Subtest noreorder-corked: SUCCESS (7.683s)
[69.246627] [005/130] (946s left) kms_vblank (query-idle-hang)
[69.340595] Starting subtest: query-idle-hang
[69.342859] Starting dynamic subtest: pipe-A-eDP-1
[95.632651] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.289s)
[95.645614] Starting dynamic subtest: pipe-D-eDP-1
[120.663445] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[120.665669] Subtest query-idle-hang: SUCCESS (51.320s)
[121.441578] [006/130] (894s left) gem_bad_reloc (negative-reloc-lut)
[121.504028] Subtest negative-reloc-lut: SKIP (0.000s)
[121.587052] [007/130] (894s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[121.690038] Starting subtest: psr-rgb101010-draw-render
[128.744730] Subtest psr-rgb101010-draw-render: SUCCESS (7.057s)
[128.885208] [008/130] (887s left) syncobj_eventfd (binary-wait-before-signal)
[128.942656] Starting subtest: binary-wait-before-signal
[128.971836] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[129.041829] [009/130] (887s left) kms_plane_multiple (tiling-yf)
[129.136622] Starting subtest: tiling-yf
[129.141332] Subtest tiling-yf: SKIP (0.000s)
[129.208967] [010/130] (886s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[129.302553] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[136.282901] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.982s)
[136.390224] [011/130] (879s left) perf (gen12-oa-tlb-invalidate)
[136.505483] Starting subtest: gen12-oa-tlb-invalidate
[136.507484] Starting dynamic subtest: 0-rcs0
[146.551708] Dynamic subtest 0-rcs0: SUCCESS (10.046s)
[146.559300] Starting dynamic subtest: 1-vecs0
[156.601830] Dynamic subtest 1-vecs0: SUCCESS (10.049s)
[156.604308] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.096s)
[156.645769] [012/130] (859s left) vgem_basic (second-client)
[156.706048] Starting subtest: second-client
[156.727622] Subtest second-client: SUCCESS (0.022s)
[156.777751] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[156.781247] [013/130] (859s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[161.774318] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[161.779102] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[162.623437] [014/130] (853s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[162.728936] Starting subtest: primary-y-tiled-reflect-x-270
[162.733431] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[162.800123] [015/130] (853s left) gem_caching (reads)
[162.863987] Subtest reads: SKIP (0.000s)
[162.951155] [016/130] (853s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[163.059015] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[163.069659] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[163.160753] [017/130] (853s left) syncobj_wait (single-wait-all-submitted)
[163.216869] Starting subtest: single-wait-all-submitted
[163.318801] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[163.399423] [018/130] (853s left) gem_mmap_offset (blt-coherency)
[163.456788] Starting subtest: blt-coherency
[163.463938] Subtest blt-coherency: SUCCESS (0.009s)
[163.596199] [019/130] (852s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[163.703270] Starting subtest: x-tiled-8bpp-rotate-180
[164.792767] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.090s)
[164.935286] [020/130] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[165.034196] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[165.038256] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[165.139886] [021/130] (851s left) gen9_exec_parse (bb-start-cmd)
[165.202713] Subtest bb-start-cmd: SKIP (0.000s)
[165.287768] [022/130] (851s left) gem_exec_flush (basic-wb-pro-default)
[165.354366] Starting subtest: basic-wb-pro-default
[170.802314] Subtest basic-wb-pro-default: SUCCESS (5.448s)
[170.980984] [023/130] (845s left) kms_scaling_modes (scaling-mode-full-aspect)
[171.081971] Starting subtest: scaling-mode-full-aspect
[171.084316] Starting dynamic subtest: pipe-A-eDP-1
[171.179810] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[171.188169] Starting dynamic subtest: pipe-B-eDP-1
[172.352788] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.172s)
[172.362917] Starting dynamic subtest: pipe-C-eDP-1
[173.455880] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[173.464185] Starting dynamic subtest: pipe-D-eDP-1
[174.576633] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[174.579063] Subtest scaling-mode-full-aspect: SUCCESS (3.495s)
[175.740378] [024/130] (841s left) syncobj_wait (single-wait-all-for-submit-signaled)
[175.792200] Starting subtest: single-wait-all-for-submit-signaled
[175.794466] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[175.906512] [025/130] (840s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[176.013090] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[185.123845] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (9.112s)
[185.258264] [026/130] (831s left) gem_userptr_blits (coherency-unsync)
[185.316742] Subtest coherency-unsync: SKIP (0.000s)
[185.451220] [027/130] (831s left) kms_chamelium_hpd (dp-hpd)
[185.850598] Subtest dp-hpd: SKIP (0.000s)
[186.609372] [028/130] (830s left) sw_sync (alloc_fence)
[186.643514] Starting subtest: alloc_fence
[186.645879] Subtest alloc_fence: SUCCESS (0.000s)
[186.693622] [029/130] (830s left) gem_workarounds (basic-read)
[186.758766] Starting subtest: basic-read
[186.769800] Subtest basic-read: SUCCESS (0.011s)
[186.902546] [030/130] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[187.004236] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[193.752625] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.751s)
[193.873935] [031/130] (823s left) perf (whitelisted-registers-userspace-config)
[193.952305] Starting subtest: whitelisted-registers-userspace-config
[193.954656] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[193.996154] [032/130] (823s left) gem_create (create-clear)
[194.056152] Starting subtest: create-clear
[194.058181] Starting dynamic subtest: smem0
[226.763341] Dynamic subtest smem0: SUCCESS (32.704s)
[226.765277] Subtest create-clear: SUCCESS (32.704s)
[226.951652] [033/130] (790s left) gem_close (many-handles-one-vma)
[227.007314] Starting subtest: many-handles-one-vma
[227.052606] Subtest many-handles-one-vma: SUCCESS (0.045s)
[227.194900] [034/130] (789s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[227.288084] Starting subtest: bad-aux-stride-yf-tiled-ccs
[227.290466] Starting dynamic subtest: pipe-A-eDP-1
[227.313599] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[227.322880] Starting dynamic subtest: pipe-B-eDP-1
[227.344611] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[227.351303] Starting dynamic subtest: pipe-C-eDP-1
[227.372966] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[227.379546] Starting dynamic subtest: pipe-D-eDP-1
[227.402324] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[227.406816] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s)
[229.429581] [035/130] (787s left) kms_cursor_crc (cursor-sliding-32x10)
[229.597802] Starting subtest: cursor-sliding-32x10
[229.639132] Subtest cursor-sliding-32x10: SKIP (0.037s)
[229.904090] [036/130] (787s left) api_intel_bb (simple-bb-ctx)
[229.951416] Starting subtest: simple-bb-ctx
[229.957384] Subtest simple-bb-ctx: SUCCESS (0.008s)
[230.084254] [037/130] (787s left) syncobj_eventfd (invalid-illegal-eventfd)
[230.136156] Starting subtest: invalid-illegal-eventfd
[230.138103] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[230.233585] [038/130] (787s left) gem_exec_reloc (basic-wc-read-noreloc)
[230.296680] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[230.360223] [039/130] (786s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[230.451670] Starting subtest: fbcpsr-tiling-4
[237.464523] Subtest fbcpsr-tiling-4: SUCCESS (7.015s)
[237.617330] [040/130] (779s left) gem_mmap_gtt (basic-small-bo-tiledy)
[237.680480] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[237.745360] [041/130] (779s left) gem_exec_reloc (basic-write-wc-active)
[237.801906] Subtest basic-write-wc-active: SKIP (0.000s)
[237.862565] [042/130] (779s left) gem_exec_balancer (persistence)
[238.120963] Starting subtest: persistence
[238.984329] Subtest persistence: SUCCESS (0.864s)
[239.126605] [043/130] (778s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[239.231107] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[239.233478] Starting dynamic subtest: pipe-A-eDP-1
[239.256119] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.265171] Starting dynamic subtest: pipe-B-eDP-1
[239.286431] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.292892] Starting dynamic subtest: pipe-C-eDP-1
[239.314396] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.321575] Starting dynamic subtest: pipe-D-eDP-1
[239.343355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.347813] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[241.482242] [044/130] (776s left) kms_flip (flip-vs-suspend)
[241.584902] Starting subtest: flip-vs-suspend
[241.587691] Starting dynamic subtest: A-eDP1
[290.992201] Dynamic subtest A-eDP1: SUCCESS (4.483s)
[291.001162] Starting dynamic subtest: B-eDP1
[340.002936] Dynamic subtest B-eDP1: SUCCESS (4.262s)
[340.013672] Starting dynamic subtest: C-eDP1
[388.997953] Dynamic subtest C-eDP1: SUCCESS (4.284s)
[389.010629] Starting dynamic subtest: D-eDP1
[437.993641] Dynamic subtest D-eDP1: SUCCESS (4.330s)
[437.996250] Subtest flip-vs-suspend: SUCCESS (17.368s)
[439.208537] [045/130] (578s left) kms_setmode (invalid-clone-single-crtc)
[439.278440] Starting subtest: invalid-clone-single-crtc
[439.286099] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[439.383975] [046/130] (578s left) sw_sync (sync_busy_fork)
[439.416412] Starting subtest: sync_busy_fork
[440.428399] Subtest sync_busy_fork: SUCCESS (1.011s)
[440.489871] [047/130] (577s left) kms_pm_rpm (pc8-residency)
[442.109431] Starting subtest: pc8-residency
[442.115121] Subtest pc8-residency: SKIP (0.000s)
[442.743924] [048/130] (574s left) gem_exec_reloc (basic-write-gtt-noreloc)
[442.807621] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[442.899849] [049/130] (574s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[443.013152] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[443.018346] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[443.106583] [050/130] (574s left) perf (invalid-open-flags)
[443.178030] Starting subtest: invalid-open-flags
[443.180816] Subtest invalid-open-flags: SUCCESS (0.000s)
[443.220202] [051/130] (574s left) kms_psr (fbc-pr-cursor-render)
[443.309614] Starting subtest: fbc-pr-cursor-render
[443.314662] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[443.382734] [052/130] (574s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[443.483260] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[443.488253] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[443.589972] [053/130] (574s left) kms_plane_scaling (intel-max-src-size)
[443.685997] Starting subtest: intel-max-src-size
[443.691880] Subtest intel-max-src-size: SKIP (0.000s)
[443.795972] [054/130] (574s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[443.891210] Starting subtest: modeset-transition-nonblocking-fencing
[443.893391] Starting dynamic subtest: 1x-outputs
[455.054099] Dynamic subtest 1x-outputs: SUCCESS (11.156s)
[455.337548] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.439s)
[456.166174] [055/130] (561s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[456.252094] Starting subtest: compare-crc-sanitycheck-xr24
[456.254532] Starting dynamic subtest: pipe-A-eDP-1
[456.847852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[456.856800] Starting dynamic subtest: pipe-B-eDP-1
[458.112526] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.262s)
[458.120912] Starting dynamic subtest: pipe-C-eDP-1
[459.287412] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.174s)
[459.297308] Starting dynamic subtest: pipe-D-eDP-1
[460.510599] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[460.513303] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.255s)
[461.386931] [056/130] (556s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[466.419137] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[466.421631] Starting dynamic subtest: pipe-A-eDP-1
[478.464486] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.046s)
[478.474000] Starting dynamic subtest: pipe-B-eDP-1
[490.477424] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.008s)
[490.479867] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.059s)
[491.311360] [057/130] (526s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[491.419488] Starting subtest: psr-1p-primscrn-spr-indfb-move
[498.733463] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.317s)
[498.892040] [058/130] (519s left) gem_exec_suspend (basic-s3)
[498.956263] Starting subtest: basic-S3
[498.959688] Starting dynamic subtest: smem
[520.016728] Dynamic subtest smem: SUCCESS (6.987s)
[520.019757] Subtest basic-S3: SUCCESS (6.988s)
[520.202752] [059/130] (497s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[520.298756] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[520.301390] Starting dynamic subtest: pipe-A
[521.350223] Dynamic subtest pipe-A: SUCCESS (1.050s)
[521.357825] Starting dynamic subtest: pipe-B
[523.495649] Dynamic subtest pipe-B: SUCCESS (2.142s)
[523.503419] Starting dynamic subtest: pipe-C
[524.690125] Dynamic subtest pipe-C: SUCCESS (1.193s)
[524.697802] Starting dynamic subtest: pipe-D
[525.818640] Dynamic subtest pipe-D: SUCCESS (1.127s)
[525.821626] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.514s)
[527.004903] [060/130] (491s left) i915_drm_fdinfo (most-busy-check-all)
[527.046148] Starting subtest: most-busy-check-all
[527.048828] Starting dynamic subtest: rcs0
[527.054385] Dynamic subtest rcs0: SKIP (0.004s)
[527.064299] Starting dynamic subtest: bcs0
[527.069321] Dynamic subtest bcs0: SKIP (0.000s)
[527.077677] Starting dynamic subtest: vcs0
[527.083415] Dynamic subtest vcs0: SKIP (0.000s)
[527.091716] Starting dynamic subtest: vcs1
[527.096700] Dynamic subtest vcs1: SKIP (0.000s)
[527.104799] Starting dynamic subtest: vecs0
[527.109629] Dynamic subtest vecs0: SKIP (0.000s)
[527.117709] Starting dynamic subtest: ccs0
[527.122383] Dynamic subtest ccs0: SKIP (0.000s)
[527.127507] Subtest most-busy-check-all: SKIP (0.008s)
[527.166733] [061/130] (491s left) kms_chamelium_audio (dp-audio)
[527.567911] Subtest dp-audio: SKIP (0.000s)
[528.407369] [062/130] (489s left) kms_big_fb (y-tiled-addfb-size-overflow)
[528.509528] Starting subtest: y-tiled-addfb-size-overflow
[528.514290] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[528.619765] [063/130] (489s left) kms_rmfb (close-fd)
[528.715638] Starting subtest: close-fd
[528.718203] Starting dynamic subtest: pipe-A-eDP-1
[528.826186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[528.835215] Starting dynamic subtest: pipe-B-eDP-1
[529.990143] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s)
[529.999043] Starting dynamic subtest: pipe-C-eDP-1
[531.111519] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[531.120475] Starting dynamic subtest: pipe-D-eDP-1
[532.223656] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.110s)
[532.226190] Subtest close-fd: SUCCESS (3.503s)
[533.424176] [064/130] (484s left) syncobj_timeline (signal)
[533.477044] Starting subtest: signal
[533.479562] Subtest signal: SUCCESS (0.000s)
[533.597381] [065/130] (484s left) gem_eio (in-flight-immediate)
[533.818159] Starting subtest: in-flight-immediate
[541.931460] Subtest in-flight-immediate: SUCCESS (8.109s)
[542.086035] [066/130] (476s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[542.181306] Starting subtest: async-flip-with-page-flip-events-tiled
[542.554095] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[545.300275] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.743s)
[545.309312] Starting dynamic subtest: pipe-A-eDP-1-4
[547.498905] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.196s)
[547.507616] Starting dynamic subtest: pipe-A-eDP-1-4
[549.509315] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[549.519038] Starting dynamic subtest: pipe-A-eDP-1-x
[551.700340] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[552.068513] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[554.825507] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[554.836419] Starting dynamic subtest: pipe-B-eDP-1-4
[557.022844] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.197s)
[557.034518] Starting dynamic subtest: pipe-B-eDP-1-4
[559.032191] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[559.041283] Starting dynamic subtest: pipe-B-eDP-1-x
[561.221893] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[561.601131] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[564.353233] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.757s)
[564.362889] Starting dynamic subtest: pipe-C-eDP-1-4
[566.528254] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[566.537864] Starting dynamic subtest: pipe-C-eDP-1-4
[568.539184] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[568.549314] Starting dynamic subtest: pipe-C-eDP-1-x
[570.729507] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[571.091534] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[573.877525] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[573.889639] Starting dynamic subtest: pipe-D-eDP-1-4
[576.063814] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[576.073274] Starting dynamic subtest: pipe-D-eDP-1-4
[578.074224] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[578.083543] Starting dynamic subtest: pipe-D-eDP-1-x
[580.264402] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[580.266666] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.079s)
[581.454767] [067/130] (436s left) gem_tiled_partial_pwrite_pread (writes)
[581.521904] Subtest writes: SKIP (0.000s)
[581.611100] [068/130] (436s left) i915_pm_rpm (system-suspend-devices)
[583.126344] Starting subtest: system-suspend-devices
[590.593105] Subtest system-suspend-devices: SUCCESS (7.465s)
[590.946396] [069/130] (427s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[591.057938] Starting subtest: fbc-psr2-sprite-mmap-gtt
[591.060221] Starting dynamic subtest: eDP-1
[591.065020] Dynamic subtest eDP-1: SKIP (0.000s)
[591.070263] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[591.128275] [070/130] (427s left) gem_ctx_engines (independent)
[591.196489] Starting subtest: independent
[591.199269] Starting dynamic subtest: rcs0
[591.330639] Dynamic subtest rcs0: SUCCESS (0.132s)
[591.341183] Starting dynamic subtest: bcs0
[591.437545] Dynamic subtest bcs0: SUCCESS (0.108s)
[591.449651] Starting dynamic subtest: vcs0
[591.562127] Dynamic subtest vcs0: SUCCESS (0.123s)
[591.571365] Starting dynamic subtest: vcs1
[591.683883] Dynamic subtest vcs1: SUCCESS (0.121s)
[591.696149] Starting dynamic subtest: vecs0
[591.791706] Dynamic subtest vecs0: SUCCESS (0.109s)
[591.800639] Starting dynamic subtest: ccs0
[591.918088] Dynamic subtest ccs0: SUCCESS (0.124s)
[591.927757] Starting dynamic subtest: all-engines
[592.425650] Dynamic subtest all-engines: SUCCESS (0.507s)
[592.428520] Subtest independent: SUCCESS (1.228s)
[593.045398] [071/130] (425s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[593.147396] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[599.605552] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.461s)
[599.728082] [072/130] (418s left) gem_ctx_persistence (engines-hang)
[599.792253] Starting subtest: engines-hang
[599.794540] Starting dynamic subtest: rcs0
[599.903358] Dynamic subtest rcs0: SUCCESS (0.110s)
[599.912637] Starting dynamic subtest: bcs0
[600.023525] Dynamic subtest bcs0: SUCCESS (0.118s)
[600.035861] Starting dynamic subtest: vcs0
[600.142996] Dynamic subtest vcs0: SUCCESS (0.117s)
[600.154446] Starting dynamic subtest: vcs1
[600.257634] Dynamic subtest vcs1: SUCCESS (0.113s)
[600.268664] Starting dynamic subtest: vecs0
[600.375105] Dynamic subtest vecs0: SUCCESS (0.115s)
[600.386647] Starting dynamic subtest: ccs0
[600.484669] Dynamic subtest ccs0: SUCCESS (0.108s)
[600.487633] Subtest engines-hang: SUCCESS (0.692s)
[600.564012] [073/130] (418s left) api_intel_bb (blit-noreloc-purge-cache)
[600.623253] Starting subtest: blit-noreloc-purge-cache
[600.631199] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[600.760539] [074/130] (417s left) gem_exec_parallel (engines)
[600.826629] Starting subtest: engines
[600.828948] Starting dynamic subtest: basic
[602.963579] Dynamic subtest basic: SUCCESS (2.133s)
[602.972665] Starting dynamic subtest: contexts
[607.372429] Dynamic subtest contexts: SUCCESS (4.406s)
[607.385228] Starting dynamic subtest: fds
[611.155448] Dynamic subtest fds: SUCCESS (3.780s)
[611.167645] Starting dynamic subtest: userptr
[613.008021] Dynamic subtest userptr: SUCCESS (1.850s)
[613.010209] Subtest engines: SUCCESS (12.178s)
[613.196867] [075/130] (405s left) vgem_basic (dmabuf-export)
[613.248820] Starting subtest: dmabuf-export
[613.302883] Subtest dmabuf-export: SUCCESS (0.056s)
[613.420475] [076/130] (405s left) kms_invalid_mode (bad-htotal)
[613.526566] Starting subtest: bad-htotal
[613.528900] Starting dynamic subtest: pipe-A-eDP-1
[613.818404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[613.828501] Starting dynamic subtest: pipe-B-eDP-1
[613.830996] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[613.839730] Starting dynamic subtest: pipe-C-eDP-1
[613.842448] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[613.851660] Starting dynamic subtest: pipe-D-eDP-1
[613.854339] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[613.856811] Subtest bad-htotal: SUCCESS (0.300s)
[614.666081] [077/130] (404s left) gem_eio (context-create)
[614.907891] Starting subtest: context-create
[615.234922] Subtest context-create: SUCCESS (0.328s)
[615.393338] [078/130] (403s left) gem_exec_whisper (basic-queues-priority-all)
[615.453917] Starting subtest: basic-queues-priority-all
[639.237563] Subtest basic-queues-priority-all: SUCCESS (23.775s)
[639.423235] [079/130] (379s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[639.805141] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[640.583104] [080/130] (378s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[640.642136] Starting subtest: single-wait-for-submit-available-signaled
[640.644824] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[640.727409] [081/130] (378s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[640.828355] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[640.831046] Starting dynamic subtest: pipe-A-default-mode
[643.510522] Dynamic subtest pipe-A-default-mode: SUCCESS (2.681s)
[643.513419] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.683s)
[644.367095] [082/130] (374s left) i915_module_load (resize-bar)
[644.402207] Starting subtest: resize-bar
[644.412289] Subtest resize-bar: SKIP (0.006s)
[644.455694] [083/130] (374s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[644.555500] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[644.560669] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[644.676087] [084/130] (374s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[644.735583] Starting subtest: etime-single-wait-all-for-submit-submitted
[644.835641] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[644.913219] [085/130] (374s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[645.012286] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[649.373455] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.364s)
[650.547754] [086/130] (368s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[650.654300] Starting subtest: x-tiled-32bpp-rotate-270
[650.674209] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[650.807876] [087/130] (368s left) kms_cursor_crc (cursor-random-512x512)
[651.080184] Starting subtest: cursor-random-512x512
[651.085616] Subtest cursor-random-512x512: SKIP (0.001s)
[651.257766] [088/130] (368s left) vgem_basic (mmap)
[651.299407] Starting subtest: mmap
[651.347776] Subtest mmap: SUCCESS (0.053s)
[651.400263] [089/130] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[651.498900] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[651.502653] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[651.603850] [090/130] (367s left) gen3_render_mixed_blits
[651.736910] [091/130] (367s left) gem_exec_schedule (u-lateslice)
[651.794917] Starting subtest: u-lateslice
[651.796976] Starting dynamic subtest: rcs0
[651.806428] Dynamic subtest rcs0: SUCCESS (0.022s)
[651.816364] Starting dynamic subtest: bcs0
[651.824109] Dynamic subtest bcs0: SUCCESS (0.017s)
[651.833165] Starting dynamic subtest: vcs0
[651.841948] Dynamic subtest vcs0: SUCCESS (0.017s)
[651.852278] Starting dynamic subtest: vcs1
[651.859216] Dynamic subtest vcs1: SUCCESS (0.017s)
[651.868872] Starting dynamic subtest: vecs0
[651.877859] Dynamic subtest vecs0: SUCCESS (0.018s)
[651.886640] Starting dynamic subtest: ccs0
[651.899561] Dynamic subtest ccs0: SUCCESS (0.021s)
[651.902215] Subtest u-lateslice: SUCCESS (0.115s)
[653.115167] [092/130] (366s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[653.214687] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[653.217355] Starting dynamic subtest: pipe-A-eDP-1
[653.227508] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[653.238247] Starting dynamic subtest: pipe-B-eDP-1
[653.247084] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[653.256351] Starting dynamic subtest: pipe-C-eDP-1
[653.266181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[653.274971] Starting dynamic subtest: pipe-D-eDP-1
[653.284410] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[653.289374] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[655.387041] [093/130] (364s left) kms_flip (plain-flip-fb-recreate-interruptible)
[655.480415] Starting subtest: plain-flip-fb-recreate-interruptible
[655.483298] Starting dynamic subtest: A-eDP1
[664.380346] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[664.394711] Starting dynamic subtest: B-eDP1
[673.206556] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[673.216137] Starting dynamic subtest: C-eDP1
[682.024817] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[682.034893] Starting dynamic subtest: D-eDP1
[690.846210] Dynamic subtest D-eDP1: SUCCESS (8.819s)
[690.851896] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.365s)
[692.024233] [094/130] (327s left) kms_cursor_crc (cursor-offscreen-256x85)
[692.291924] Starting subtest: cursor-offscreen-256x85
[692.334025] Subtest cursor-offscreen-256x85: SKIP (0.037s)
[692.522366] [095/130] (327s left) kms_psr (pr-cursor-mmap-cpu)
[692.629269] Starting subtest: pr-cursor-mmap-cpu
[692.633807] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[692.698846] [096/130] (326s left) gem_busy (close-race)
[692.758198] Starting subtest: close-race
[717.933645] Subtest close-race: SUCCESS (25.168s)
[718.303706] [097/130] (301s left) kms_draw_crc (draw-method-mmap-wc)
[718.444385] Starting subtest: draw-method-mmap-wc
[718.446502] Starting dynamic subtest: xrgb8888-untiled
[718.641152] Dynamic subtest xrgb8888-untiled: SUCCESS (0.199s)
[718.650752] Starting dynamic subtest: rgb565-untiled
[718.830473] Dynamic subtest rgb565-untiled: SUCCESS (0.188s)
[718.840529] Starting dynamic subtest: xrgb2101010-untiled
[719.019165] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.188s)
[719.029186] Starting dynamic subtest: xbgr16161616f-untiled
[719.241269] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[719.251001] Starting dynamic subtest: xrgb8888-xtiled
[719.352969] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[719.368016] Starting dynamic subtest: rgb565-xtiled
[719.486355] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s)
[719.496417] Starting dynamic subtest: xrgb2101010-xtiled
[719.597173] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[719.607000] Starting dynamic subtest: xbgr16161616f-xtiled
[719.719685] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[719.729439] Starting dynamic subtest: xrgb8888-4tiled
[719.852663] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[719.862537] Starting dynamic subtest: rgb565-4tiled
[720.007863] Dynamic subtest rgb565-4tiled: SUCCESS (0.153s)
[720.017148] Starting dynamic subtest: xrgb2101010-4tiled
[720.130516] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[720.140294] Starting dynamic subtest: xbgr16161616f-4tiled
[720.299165] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.167s)
[720.301254] Subtest draw-method-mmap-wc: SUCCESS (1.857s)
[720.391840] [098/130] (299s left) kms_psr (pr-primary-page-flip)
[720.501868] Starting subtest: pr-primary-page-flip
[720.505183] Subtest pr-primary-page-flip: SKIP (0.000s)
[720.572919] [099/130] (299s left) gem_exec_fence (submit3)
[720.750363] Starting subtest: submit3
[720.755487] Subtest submit3: SKIP (0.000s)
[723.065761] [100/130] (296s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[723.181286] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[724.027257] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.848s)
[724.180109] [101/130] (295s left) gen7_exec_parse (basic-allocation)
[724.242249] Subtest basic-allocation: SKIP (0.000s)
[724.318557] [102/130] (295s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[724.376316] Starting subtest: invalid-single-wait-unsubmitted
[724.378792] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[724.447975] [103/130] (295s left) kms_psr (psr-cursor-blt)
[724.553183] Starting subtest: psr-cursor-blt
[724.555543] Starting dynamic subtest: eDP-1
[726.211670] Dynamic subtest eDP-1: SUCCESS (1.660s)
[726.214090] Subtest psr-cursor-blt: SUCCESS (1.660s)
[727.078507] [104/130] (292s left) kms_lease (lease-revoke)
[727.181647] Starting subtest: lease-revoke
[727.184066] Starting dynamic subtest: pipe-A-eDP-1
[727.217313] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.033s)
[727.227049] Starting dynamic subtest: pipe-B-eDP-1
[727.243484] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[727.254576] Starting dynamic subtest: pipe-C-eDP-1
[727.272580] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[727.283753] Starting dynamic subtest: pipe-D-eDP-1
[727.303157] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[727.305793] Subtest lease-revoke: SUCCESS (0.120s)
[727.443618] [105/130] (292s left) gem_mmap_offset (basic-uaf)
[727.511461] Starting subtest: basic-uaf
[727.514452] Subtest basic-uaf: SUCCESS (0.001s)
[727.605860] [106/130] (292s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[727.714818] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[727.719278] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[727.827759] [107/130] (292s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[727.887831] Starting subtest: yf-tiled-ccs-to-y-tiled
[727.892573] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[728.068522] [108/130] (292s left) kms_cursor_edge_walk (128x128-left-edge)
[728.160394] Starting subtest: 128x128-left-edge
[728.163038] Starting dynamic subtest: pipe-A-eDP-1
[731.626427] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[731.636455] Starting dynamic subtest: pipe-D-eDP-1
[734.746645] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[734.749662] Subtest 128x128-left-edge: SUCCESS (6.584s)
[735.547822] [109/130] (284s left) perf_pmu (invalid-init)
[735.589418] Starting subtest: invalid-init
[735.591651] Subtest invalid-init: SUCCESS (0.000s)
[735.703115] [110/130] (284s left) gem_exec_schedule (preemptive-hang)
[735.874621] Starting subtest: preemptive-hang
[735.877192] Starting dynamic subtest: rcs0
[745.078437] Dynamic subtest rcs0: SUCCESS (9.198s)
[745.088440] Starting dynamic subtest: bcs0
[754.098518] Dynamic subtest bcs0: SUCCESS (9.018s)
[754.107993] Starting dynamic subtest: vcs0
[763.194813] Dynamic subtest vcs0: SUCCESS (9.093s)
[763.206613] Starting dynamic subtest: vcs1
[772.087945] Dynamic subtest vcs1: SUCCESS (8.891s)
[772.097661] Starting dynamic subtest: vecs0
[781.109355] Dynamic subtest vecs0: SUCCESS (9.017s)
[781.126557] Starting dynamic subtest: ccs0
[790.134449] Dynamic subtest ccs0: SUCCESS (9.020s)
[790.137412] Subtest preemptive-hang: SUCCESS (54.244s)
[790.400931] [111/130] (229s left) gem_ctx_persistence (smoketest)
[790.458444] Starting subtest: smoketest
[830.895812] Subtest smoketest: SUCCESS (40.423s)
[830.973970] [112/130] (189s left) perf_pmu (init-sema)
[831.015699] Starting subtest: init-sema
[831.017927] Starting dynamic subtest: rcs0
[831.020370] Dynamic subtest rcs0: SUCCESS (0.002s)
[831.031448] Starting dynamic subtest: bcs0
[831.033657] Dynamic subtest bcs0: SUCCESS (0.000s)
[831.042917] Starting dynamic subtest: vcs0
[831.045124] Dynamic subtest vcs0: SUCCESS (0.001s)
[831.054704] Starting dynamic subtest: vcs1
[831.057352] Dynamic subtest vcs1: SUCCESS (0.000s)
[831.066797] Starting dynamic subtest: vecs0
[831.068900] Dynamic subtest vecs0: SUCCESS (0.001s)
[831.079081] Starting dynamic subtest: ccs0
[831.081643] Dynamic subtest ccs0: SUCCESS (0.000s)
[831.084028] Subtest init-sema: SUCCESS (0.007s)
[831.125088] [113/130] (189s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[831.229428] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[831.231898] Starting dynamic subtest: pipe-A-default-mode
[831.517608] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[831.523045] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.285s)
[832.384283] [114/130] (187s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[832.482426] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[838.619584] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.141s)
[839.768225] [115/130] (180s left) gem_spin_batch (spin-all)
[839.828432] Starting subtest: spin-all
[839.844323] Subtest spin-all: SUCCESS (0.013s)
[841.014402] [116/130] (179s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[841.109294] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[841.114490] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[841.207139] [117/130] (179s left) kms_addfb_basic (bad-pitch-256)
[841.269630] Starting subtest: bad-pitch-256
[841.271776] Subtest bad-pitch-256: SUCCESS (0.000s)
[841.410447] [118/130] (179s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[841.513147] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[841.518193] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[841.616872] [119/130] (178s left) kms_vblank (ts-continuation-modeset-hang)
[841.716632] Starting subtest: ts-continuation-modeset-hang
[841.719128] Starting dynamic subtest: pipe-A-eDP-1
[867.728103] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.004s)
[867.750211] Starting dynamic subtest: pipe-D-eDP-1
[891.737551] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.997s)
[891.740652] Subtest ts-continuation-modeset-hang: SUCCESS (50.006s)
[892.593763] [120/130] (127s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[892.697286] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[892.699241] Starting dynamic subtest: pipe-A-eDP-1
[893.491331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[893.502341] Starting dynamic subtest: pipe-B-eDP-1
[895.034640] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.542s)
[895.045936] Starting dynamic subtest: pipe-C-eDP-1
[896.509636] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.472s)
[896.522774] Starting dynamic subtest: pipe-D-eDP-1
[897.941073] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.430s)
[897.943331] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.233s)
[899.114352] [121/130] (121s left) kms_addfb_basic (legacy-format)
[899.177140] Starting subtest: legacy-format
[899.208629] Subtest legacy-format: SUCCESS (0.025s)
[899.369362] [122/130] (121s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[899.474864] Starting subtest: fbc-shrfb-scaledprimary
[904.507470] Subtest fbc-shrfb-scaledprimary: SUCCESS (5.035s)
[905.685897] [123/130] (115s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[906.083005] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[906.879276] [124/130] (113s left) gem_mmap (bad-offset)
[906.939209] Subtest bad-offset: SKIP (0.000s)
[906.996322] [125/130] (113s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[907.101971] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[907.106369] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[907.219237] [126/130] (113s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[907.345197] Starting subtest: verify-pxp-key-change-after-suspend-resume
[914.414161] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.069s)
[914.557920] [127/130] (106s left) drm_read (empty-block)
[914.719802] Starting subtest: empty-block
[915.720868] Subtest empty-block: SUCCESS (1.000s)
[915.856030] [128/130] (105s left) kms_pm_dc (dc5-dpms-negative)
[916.958111] Starting subtest: dc5-dpms-negative
[916.963181] Subtest dc5-dpms-negative: SKIP (0.000s)
[917.030706] [129/130] (103s left) kms_setmode (basic)
[917.094533] Starting subtest: basic
[917.412631] Starting dynamic subtest: pipe-A-eDP-1
[919.481939] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.065s)
[919.822420] Starting dynamic subtest: pipe-B-eDP-1
[921.909982] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.091s)
[922.216249] Subtest basic: SUCCESS (5.118s)
[923.046529] [130/130] ( 97s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[923.150508] Starting subtest: fbc-rgb101010-draw-pwrite
[928.465806] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.318s)
[929.612582] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: gem_bad_reloc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_eventfd
results: parsing output: 8/ for test: kms_plane_multiple
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: vgem_basic
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: gem_caching
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: gem_mmap_offset
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gen9_exec_parse
results: parsing output: 21/ for test: gem_exec_flush
results: parsing output: 22/ for test: kms_scaling_modes
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: gem_workarounds
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_create
results: parsing output: 32/ for test: gem_close
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: syncobj_eventfd
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_setmode
results: parsing output: 45/ for test: sw_sync
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_atomic_transition
results: parsing output: 54/ for test: kms_pipe_crc_basic
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_suspend
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: kms_chamelium_audio
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_rmfb
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_async_flips
results: parsing output: 66/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 67/ for test: i915_pm_rpm
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_ctx_engines
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: gem_exec_parallel
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: kms_invalid_mode
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: i915_module_load
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: vgem_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gen3_render_mixed_blits
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_busy
results: parsing output: 96/ for test: kms_draw_crc
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gen7_exec_parse
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_cursor_edge_walk
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_spin_batch
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: gem_mmap
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_pxp
results: parsing output: 126/ for test: drm_read
results: parsing output: 127/ for test: kms_pm_dc
results: parsing output: 128/ for test: kms_setmode
results: parsing output: 129/ for test: kms_frontbuffer_tracking
Done.