[57.197652] Initializing watchdogs
[57.197723]   /dev/watchdog0
[57.214392] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.218641] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.220951] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.224182] [001/131] (960s left) gem_mmap_gtt (big-bo)
[57.307260] Subtest big-bo: SKIP (0.000s)
[57.370532] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[57.476434] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[79.993731] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.478s)
[80.166949] [003/131] (937s left) gem_ppgtt (blt-vs-render-ctxn)
[80.230506] Starting subtest: blt-vs-render-ctxN
[113.220767] Subtest blt-vs-render-ctxN: SUCCESS (32.980s)
[113.386293] [004/131] (904s left) gem_wait (write-busy)
[113.499673] Starting subtest: write-busy
[113.502159] Starting dynamic subtest: all-engines
[114.200679] Dynamic subtest all-engines: SUCCESS (0.701s)
[114.215068] Starting dynamic subtest: rcs0
[114.752238] Dynamic subtest rcs0: SUCCESS (0.550s)
[114.766222] Starting dynamic subtest: bcs0
[115.300709] Dynamic subtest bcs0: SUCCESS (0.547s)
[115.314413] Starting dynamic subtest: vcs0
[116.886318] Dynamic subtest vcs0: SUCCESS (1.584s)
[116.899839] Starting dynamic subtest: vcs1
[118.932922] Dynamic subtest vcs1: SUCCESS (2.045s)
[118.946534] Starting dynamic subtest: vecs0
[120.917294] Dynamic subtest vecs0: SUCCESS (1.982s)
[120.930988] Starting dynamic subtest: ccs0
[121.467195] Dynamic subtest ccs0: SUCCESS (0.550s)
[121.469667] Subtest write-busy: SUCCESS (7.967s)
[121.683627] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[121.686861] [005/131] (896s left) kms_lease (atomic-implicit-crtc)
[121.793890] Starting subtest: atomic-implicit-crtc
[121.796245] Starting dynamic subtest: pipe-A-eDP-1
[121.807328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[121.815340] Starting dynamic subtest: pipe-B-eDP-1
[121.826585] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[121.833588] Starting dynamic subtest: pipe-C-eDP-1
[121.843929] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[121.850884] Starting dynamic subtest: pipe-D-eDP-1
[121.861166] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[121.863099] Subtest atomic-implicit-crtc: SUCCESS (0.031s)
[121.966434] [006/131] (895s left) i915_pm_freq_api (freq-reset)
[122.040621] Starting subtest: freq-reset
[122.043063] Starting dynamic subtest: gt0
[122.226323] Dynamic subtest gt0: SUCCESS (0.185s)
[122.234451] Starting dynamic subtest: gt1
[122.385310] Dynamic subtest gt1: SUCCESS (0.157s)
[122.387370] Subtest freq-reset: SUCCESS (0.343s)
[122.483441] [007/131] (895s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[122.603860] Starting subtest: cursorA-vs-flipA-legacy
[133.759519] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.152s)
[134.640680] [008/131] (883s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[134.699521] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[134.765512] [009/131] (883s left) i915_drm_fdinfo (memory-info-purgeable)
[134.804677] Starting subtest: memory-info-purgeable
[134.807058] Starting dynamic subtest: smem0
[137.463631] Dynamic subtest smem0: SUCCESS (2.660s)
[137.465829] Subtest memory-info-purgeable: SUCCESS (2.660s)
[137.560286] [010/131] (880s left) gem_partial_pwrite_pread (write)
[137.620594] Subtest write: SKIP (0.000s)
[137.702169] [011/131] (880s left) gem_ctx_exec (basic-invalid-context)
[137.769569] Starting subtest: basic-invalid-context
[137.776145] Subtest basic-invalid-context: SUCCESS (0.007s)
[137.932768] [012/131] (880s left) kms_atomic_transition (plane-toggle-modeset-transition)
[138.034843] Starting subtest: plane-toggle-modeset-transition
[138.036544] Starting dynamic subtest: pipe-A-eDP-1
[150.748901] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.711s)
[150.759534] Starting dynamic subtest: pipe-B-eDP-1
[163.142216] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.389s)
[163.144856] Subtest plane-toggle-modeset-transition: SUCCESS (25.106s)
[163.983164] [013/131] (854s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[164.175488] Starting subtest: cursor-rapid-movement-64x21
[164.225245] Subtest cursor-rapid-movement-64x21: SKIP (0.043s)
[164.503590] [014/131] (853s left) gem_exec_reloc (basic-scanout)
[164.567785] Subtest basic-scanout: SKIP (0.000s)
[164.646100] [015/131] (853s left) kms_dsc (dsc-with-bpc)
[164.743850] Starting subtest: dsc-with-bpc
[164.774758] Subtest dsc-with-bpc: SKIP (0.001s)
[164.839119] [016/131] (853s left) kms_chamelium_color (ctm-green-to-red)
[164.924887] Subtest ctm-green-to-red: SKIP (0.000s)
[164.966499] [017/131] (853s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[165.058875] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[169.187091] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.129s)
[170.387308] [018/131] (847s left) gem_exec_reloc (basic-wc-cpu-active)
[170.447478] Subtest basic-wc-cpu-active: SKIP (0.000s)
[170.505937] [019/131] (847s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[170.609791] Starting subtest: x-tiled-8bpp-rotate-180
[171.822442] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.214s)
[171.980484] [020/131] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[172.076089] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[172.079508] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[172.217834] [021/131] (846s left) gem_exec_fence (syncobj-channel)
[172.648982] Starting subtest: syncobj-channel
[173.665491] Subtest syncobj-channel: SUCCESS (1.015s)
[174.047907] [022/131] (844s left) gem_busy (extended)
[174.232708] Starting subtest: extended
[174.234771] Starting dynamic subtest: rcs0
[174.344134] Dynamic subtest rcs0: SUCCESS (0.114s)
[174.354823] Starting dynamic subtest: bcs0
[174.390784] Dynamic subtest bcs0: SUCCESS (0.044s)
[174.400675] Starting dynamic subtest: vcs0
[175.893996] Dynamic subtest vcs0: SUCCESS (1.500s)
[175.905126] Starting dynamic subtest: vcs1
[177.940622] Dynamic subtest vcs1: SUCCESS (2.045s)
[177.951635] Starting dynamic subtest: vecs0
[179.925687] Dynamic subtest vecs0: SUCCESS (1.982s)
[179.936445] Starting dynamic subtest: ccs0
[179.972172] Dynamic subtest ccs0: SUCCESS (0.046s)
[179.974605] Subtest extended: SUCCESS (5.743s)
[180.258127] [023/131] (838s left) gem_exec_flush (basic-uc-rw-default)
[180.318787] Starting subtest: basic-uc-rw-default
[185.783158] Subtest basic-uc-rw-default: SUCCESS (5.464s)
[185.989371] [024/131] (832s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[186.381737] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[187.154393] [025/131] (831s left) kms_lease (setcrtc-implicit-plane)
[187.241187] Starting subtest: setcrtc-implicit-plane
[187.243083] Starting dynamic subtest: pipe-A-eDP-1
[187.707404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[187.716211] Starting dynamic subtest: pipe-B-eDP-1
[188.775642] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.069s)
[188.783724] Starting dynamic subtest: pipe-C-eDP-1
[189.912083] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.134s)
[189.921437] Starting dynamic subtest: pipe-D-eDP-1
[191.045748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[191.048126] Subtest setcrtc-implicit-plane: SUCCESS (3.805s)
[191.903892] [026/131] (826s left) kms_frontbuffer_tracking (fbc-tiling-y)
[192.005403] Starting subtest: fbc-tiling-y
[192.009292] Subtest fbc-tiling-y: SKIP (0.000s)
[192.129470] [027/131] (826s left) kms_prop_blob (blob-prop-validate)
[192.187160] Starting subtest: blob-prop-validate
[192.189350] Subtest blob-prop-validate: SUCCESS (0.000s)
[192.307134] [028/131] (826s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[192.413933] Starting subtest: flip-vs-dpms-on-nop-interruptible
[192.416275] Starting dynamic subtest: A-eDP1
[194.279154] Dynamic subtest A-eDP1: SUCCESS (1.864s)
[194.287477] Starting dynamic subtest: B-eDP1
[196.106687] Dynamic subtest B-eDP1: SUCCESS (1.826s)
[196.114458] Starting dynamic subtest: C-eDP1
[197.933272] Dynamic subtest C-eDP1: SUCCESS (1.824s)
[197.941753] Starting dynamic subtest: D-eDP1
[199.782871] Dynamic subtest D-eDP1: SUCCESS (1.849s)
[199.788538] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.373s)
[200.986877] [029/131] (817s left) kms_psr (psr2-sprite-plane-onoff)
[201.090685] Starting subtest: psr2-sprite-plane-onoff
[201.093069] Starting dynamic subtest: eDP-1
[202.861794] Dynamic subtest eDP-1: SUCCESS (1.768s)
[202.863809] Subtest psr2-sprite-plane-onoff: SUCCESS (1.769s)
[203.741629] [030/131] (815s left) syncobj_wait (multi-wait-signaled)
[203.809641] Starting subtest: multi-wait-signaled
[203.811667] Subtest multi-wait-signaled: SUCCESS (0.000s)
[203.939868] [031/131] (814s left) gem_ctx_shared (q-promotion)
[204.006607] Starting subtest: Q-promotion
[204.009043] Starting dynamic subtest: rcs0
[204.109658] Dynamic subtest rcs0: SUCCESS (0.102s)
[204.125061] Starting dynamic subtest: vcs0
[204.192272] Dynamic subtest vcs0: SUCCESS (0.082s)
[204.206482] Starting dynamic subtest: vcs1
[204.266364] Dynamic subtest vcs1: SUCCESS (0.074s)
[204.282036] Starting dynamic subtest: vecs0
[204.340616] Dynamic subtest vecs0: SUCCESS (0.074s)
[204.355982] Starting dynamic subtest: ccs0
[204.413549] Dynamic subtest ccs0: SUCCESS (0.071s)
[204.416517] Subtest Q-promotion: SUCCESS (0.406s)
[206.045818] [032/131] (812s left) tools_test (tools_test)
[206.101085] Starting subtest: tools_test
[206.161039] Subtest tools_test: SUCCESS (0.074s)
[206.241296] [033/131] (812s left) gem_softpin (evict-active-interruptible)
[206.316742] Starting subtest: evict-active-interruptible
[206.325327] Subtest evict-active-interruptible: SUCCESS (0.009s)
[206.512209] [034/131] (812s left) sw_sync (alloc_timeline)
[206.545042] Starting subtest: alloc_timeline
[206.547850] Subtest alloc_timeline: SUCCESS (0.000s)
[206.627219] [035/131] (812s left) gem_eio (in-flight-1us)
[206.890869] Starting subtest: in-flight-1us
[215.805243] Subtest in-flight-1us: SUCCESS (8.911s)
[215.991365] [036/131] (803s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[216.089251] Starting subtest: 4-tiled-64bpp-rotate-270
[216.107983] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.018s)
[216.262786] [037/131] (802s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[216.359711] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[216.363814] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[216.501288] [038/131] (802s left) gem_mmap_offset (partial-mmap)
[216.559502] Starting subtest: partial-mmap
[216.561389] Starting dynamic subtest: smem0
[216.562999] Dynamic subtest smem0: SUCCESS (0.004s)
[216.565053] Subtest partial-mmap: SUCCESS (0.004s)
[216.702153] [039/131] (802s left) i915_selftest (perf)
[220.191385] Starting subtest: perf
[220.197388] Starting dynamic subtest: engine_cs
[224.649881] Dynamic subtest engine_cs: SUCCESS (4.457s)
[224.657870] Starting dynamic subtest: request
[231.991779] Dynamic subtest request: SUCCESS (7.341s)
[232.005810] Starting dynamic subtest: migrate
[236.375867] Dynamic subtest migrate: SUCCESS (4.381s)
[236.384738] Starting dynamic subtest: region
[240.838074] Dynamic subtest region: SUCCESS (4.460s)
[240.841047] Subtest perf: SUCCESS (20.646s)
[240.870814] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[240.871522] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[240.874691] [040/131] (778s left) kms_content_protection (dp-mst-type-1)
[242.519170] Starting subtest: dp-mst-type-1
[242.523480] Subtest dp-mst-type-1: SKIP (0.000s)
[242.620281] [FACT kms_content_protection (dp-mst-type-1)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[242.621422] [FACT kms_content_protection (dp-mst-type-1)] new: kernel.kmod_is_loaded.i915: true
[242.624866] [041/131] (776s left) gem_exec_alignment (single)
[242.690168] Starting subtest: single
[242.695568] Subtest single: SUCCESS (0.003s)
[242.852764] [042/131] (776s left) api_intel_bb (object-noreloc-keep-cache-simple)
[242.913287] Starting subtest: object-noreloc-keep-cache-simple
[242.920279] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.009s)
[243.088382] [043/131] (776s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[243.148798] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[243.257914] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[243.358408] [044/131] (776s left) prime_vgem (basic-read)
[243.439638] Starting subtest: basic-read
[243.446841] Subtest basic-read: SKIP (0.005s)
[243.576545] [045/131] (775s left) perf_pmu (most-busy-idle-check-all)
[243.618278] Starting subtest: most-busy-idle-check-all
[243.620038] Starting dynamic subtest: rcs0
[244.887337] Dynamic subtest rcs0: SUCCESS (1.268s)
[244.898575] Starting dynamic subtest: bcs0
[246.933847] Dynamic subtest bcs0: SUCCESS (2.044s)
[246.944413] Starting dynamic subtest: vcs0
[248.919085] Dynamic subtest vcs0: SUCCESS (1.982s)
[248.929496] Starting dynamic subtest: vcs1
[250.902680] Dynamic subtest vcs1: SUCCESS (1.981s)
[250.913373] Starting dynamic subtest: vecs0
[252.886704] Dynamic subtest vecs0: SUCCESS (1.981s)
[252.896992] Starting dynamic subtest: ccs0
[254.934811] Dynamic subtest ccs0: SUCCESS (2.045s)
[254.937893] Subtest most-busy-idle-check-all: SUCCESS (11.317s)
[255.071267] [046/131] (764s left) kms_flip (flip-vs-blocking-wf-vblank)
[255.185024] Starting subtest: flip-vs-blocking-wf-vblank
[255.187562] Starting dynamic subtest: A-eDP1
[264.102394] Dynamic subtest A-eDP1: SUCCESS (8.916s)
[264.112392] Starting dynamic subtest: B-eDP1
[273.041793] Dynamic subtest B-eDP1: SUCCESS (8.938s)
[273.052209] Starting dynamic subtest: C-eDP1
[281.955237] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[281.965104] Starting dynamic subtest: D-eDP1
[290.879103] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[290.881568] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.695s)
[292.135151] [047/131] (727s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[292.243060] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[292.247565] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[292.358805] [048/131] (727s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[292.418529] Starting subtest: multi-wait-all-for-submit-available-submitted
[292.420770] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[292.542438] [049/131] (727s left) api_intel_allocator (execbuf-with-allocator)
[292.605488] Starting subtest: execbuf-with-allocator
[292.610773] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[292.776938] [050/131] (726s left) gem_lmem_swapping (parallel-random)
[292.816417] Subtest parallel-random: SKIP (0.000s)
[292.862970] [051/131] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[292.965708] Starting subtest: fbcpsr-1p-rte
[299.929120] Subtest fbcpsr-1p-rte: SUCCESS (6.966s)
[300.097897] [052/131] (719s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[300.211677] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[300.216152] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[300.332646] [053/131] (719s left) gem_exec_schedule (preempt-engines)
[300.410322] Starting subtest: preempt-engines
[300.412690] Starting dynamic subtest: rcs0
[302.662991] Dynamic subtest rcs0: SUCCESS (2.261s)
[302.674273] Starting dynamic subtest: bcs0
[304.911508] Dynamic subtest bcs0: SUCCESS (2.246s)
[304.923616] Starting dynamic subtest: vcs0
[307.169075] Dynamic subtest vcs0: SUCCESS (2.255s)
[307.181234] Starting dynamic subtest: vcs1
[309.418505] Dynamic subtest vcs1: SUCCESS (2.248s)
[309.426748] Starting dynamic subtest: vecs0
[311.669085] Dynamic subtest vecs0: SUCCESS (2.248s)
[311.678151] Starting dynamic subtest: ccs0
[313.935688] Dynamic subtest ccs0: SUCCESS (2.264s)
[313.938802] Subtest preempt-engines: SUCCESS (13.534s)
[314.343103] [054/131] (705s left) gen9_exec_parse (secure-batches)
[314.407727] Subtest secure-batches: SKIP (0.000s)
[314.488390] [055/131] (705s left) kms_getfb (getfb-addfb-different-handles)
[314.583810] Starting subtest: getfb-addfb-different-handles
[314.585958] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[314.725861] [056/131] (705s left) kms_pm_rpm (modeset-lpsp)
[316.263711] Starting subtest: modeset-lpsp
[317.717606] Subtest modeset-lpsp: SUCCESS (1.457s)
[317.829232] [057/131] (702s left) kms_atomic_interruptible (universal-setplane-cursor)
[317.929442] Starting subtest: universal-setplane-cursor
[317.931875] Starting dynamic subtest: pipe-A-eDP-1
[325.303426] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.372s)
[325.305470] Subtest universal-setplane-cursor: SUCCESS (7.374s)
[326.170446] [058/131] (693s left) i915_query (query-topology-kernel-writes)
[326.231769] Starting subtest: query-topology-kernel-writes
[326.233847] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[326.342931] [059/131] (693s left) gem_tiled_wb
[326.460194] [060/131] (693s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[326.559043] Starting subtest: yf-tiled-8bpp-rotate-180
[326.563565] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[326.687819] [061/131] (693s left) kms_plane_scaling (planes-downscale-factor-0-5)
[326.784314] Starting subtest: planes-downscale-factor-0-5
[326.786610] Starting dynamic subtest: pipe-A
[326.804981] Dynamic subtest pipe-A: SKIP (0.017s)
[326.813802] Starting dynamic subtest: pipe-B
[326.834392] Dynamic subtest pipe-B: SKIP (0.029s)
[326.842256] Starting dynamic subtest: pipe-C
[326.863116] Dynamic subtest pipe-C: SKIP (0.028s)
[326.872197] Starting dynamic subtest: pipe-D
[326.890529] Dynamic subtest pipe-D: SKIP (0.027s)
[326.894254] Subtest planes-downscale-factor-0-5: SKIP (0.104s)
[327.004537] [062/131] (693s left) gem_exec_schedule (preempt-queue-contexts-chain)
[327.083460] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[327.398084] [063/131] (692s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[327.489662] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[331.066430] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.581s)
[332.260903] [064/131] (687s left) kms_invalid_mode (bad-vtotal)
[332.363321] Starting subtest: bad-vtotal
[332.365712] Starting dynamic subtest: pipe-A-eDP-1
[332.651885] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[332.661651] Starting dynamic subtest: pipe-B-eDP-1
[332.663690] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[332.670673] Starting dynamic subtest: pipe-C-eDP-1
[332.672663] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[332.679969] Starting dynamic subtest: pipe-D-eDP-1
[332.682529] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[332.684663] Subtest bad-vtotal: SUCCESS (0.294s)
[333.472616] [065/131] (686s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[333.573105] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[333.575441] Starting dynamic subtest: pipe-A-eDP-1
[333.596343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[333.605968] Starting dynamic subtest: pipe-B-eDP-1
[333.624713] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[333.632645] Starting dynamic subtest: pipe-C-eDP-1
[333.651724] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[333.660975] Starting dynamic subtest: pipe-D-eDP-1
[333.680182] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[333.682069] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[335.751260] [066/131] (684s left) gem_exec_balancer (invalid-balancer)
[335.836334] Starting subtest: invalid-balancer
[336.682399] Subtest invalid-balancer: SUCCESS (0.844s)
[337.014046] [067/131] (683s left) kms_plane_scaling (planes-upscale-20x20)
[337.128138] Starting subtest: planes-upscale-20x20
[337.130398] Starting dynamic subtest: pipe-A
[337.187772] Dynamic subtest pipe-A: SUCCESS (0.062s)
[337.197627] Starting dynamic subtest: pipe-B
[338.360250] Dynamic subtest pipe-B: SUCCESS (1.171s)
[338.369940] Starting dynamic subtest: pipe-C
[339.470101] Dynamic subtest pipe-C: SUCCESS (1.108s)
[339.480963] Starting dynamic subtest: pipe-D
[340.605392] Dynamic subtest pipe-D: SUCCESS (1.134s)
[340.607794] Subtest planes-upscale-20x20: SUCCESS (3.481s)
[341.789759] [068/131] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[341.889657] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[341.893762] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[342.018115] [069/131] (678s left) gem_mmap_wc (read-write)
[342.069859] Subtest read-write: SKIP (0.000s)
[342.125853] [070/131] (678s left) gem_pxp (create-regular-context-1)
[342.248825] Starting subtest: create-regular-context-1
[342.251475] Subtest create-regular-context-1: SUCCESS (0.002s)
[342.384674] [071/131] (678s left) kms_addfb_basic (invalid-get-prop)
[342.453444] Starting subtest: invalid-get-prop
[342.455295] Subtest invalid-get-prop: SUCCESS (0.000s)
[342.617842] [072/131] (677s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[342.722278] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[347.130370] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.410s)
[348.287129] [073/131] (672s left) syncobj_timeline (wait-all-complex)
[348.353634] Starting subtest: wait-all-complex
[348.566997] Subtest wait-all-complex: SUCCESS (0.212s)
[348.663487] [074/131] (671s left) gem_softpin (zero)
[348.726640] Starting subtest: zero
[348.731440] Subtest zero: SUCCESS (0.004s)
[348.874956] [075/131] (671s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[348.984616] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[348.988996] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[349.128144] [076/131] (671s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[349.225304] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[349.227620] Starting dynamic subtest: pipe-A-eDP-1
[349.250362] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[349.260450] Starting dynamic subtest: pipe-B-eDP-1
[349.281371] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[349.288868] Starting dynamic subtest: pipe-C-eDP-1
[349.310182] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[349.317498] Starting dynamic subtest: pipe-D-eDP-1
[349.338975] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[349.343270] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[351.455237] [077/131] (669s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[351.571526] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[352.991058] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.420s)
[353.817545] [078/131] (666s left) kms_vrr (negative-basic)
[353.917142] Starting subtest: negative-basic
[353.923924] Starting dynamic subtest: pipe-A-eDP-1
[359.338575] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.414s)
[359.628992] Subtest negative-basic: SUCCESS (5.707s)
[360.442099] [079/131] (660s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[360.535132] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[360.537386] Starting dynamic subtest: pipe-A-default-mode
[360.828256] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[360.833140] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.291s)
[361.664640] [080/131] (659s left) syncobj_timeline (single-wait-all-available-signaled)
[361.726524] Starting subtest: single-wait-all-available-signaled
[361.728829] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[361.852311] [081/131] (659s left) gem_reg_read (bad-register)
[361.915696] Starting subtest: bad-register
[361.917834] Subtest bad-register: SUCCESS (0.000s)
[362.047607] [082/131] (658s left) gem_exec_fence (basic-wait-all)
[362.113755] Starting subtest: basic-wait-all
[362.216705] Subtest basic-wait-all: SUCCESS (0.103s)
[364.041147] [083/131] (656s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[364.134449] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[364.138515] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[364.260069] [084/131] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[364.364701] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[364.368736] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[364.499490] [085/131] (656s left) gem_ctx_persistence (engines-queued)
[364.572399] Starting subtest: engines-queued
[364.574656] Starting dynamic subtest: rcs0
[364.657870] Dynamic subtest rcs0: SUCCESS (0.085s)
[364.668429] Starting dynamic subtest: bcs0
[364.731568] Dynamic subtest bcs0: SUCCESS (0.072s)
[364.742701] Starting dynamic subtest: vcs0
[365.876247] Dynamic subtest vcs0: SUCCESS (1.141s)
[365.887272] Starting dynamic subtest: vcs1
[367.859095] Dynamic subtest vcs1: SUCCESS (1.979s)
[367.870191] Starting dynamic subtest: vecs0
[369.843511] Dynamic subtest vecs0: SUCCESS (1.981s)
[369.855898] Starting dynamic subtest: ccs0
[370.025536] Dynamic subtest ccs0: SUCCESS (0.182s)
[370.027921] Subtest engines-queued: SUCCESS (5.453s)
[370.172251] [086/131] (650s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[370.291547] Starting subtest: fbcpsr-rgb565-draw-render
[377.147099] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.857s)
[377.317909] [087/131] (643s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[377.430743] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[377.435192] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[377.562769] [088/131] (643s left) gem_create (create-ext-placement-each)
[377.746654] Starting subtest: create-ext-placement-each
[377.749109] Subtest create-ext-placement-each: SUCCESS (0.000s)
[377.896592] [089/131] (643s left) kms_psr2_su (page_flip-p010)
[377.968808] Subtest page_flip-P010: SKIP (0.000s)
[378.035638] [090/131] (643s left) kms_plane_multiple (tiling-x)
[378.122348] Starting subtest: tiling-x
[378.124676] Starting dynamic subtest: pipe-A-eDP-1
[381.762563] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.639s)
[381.771458] Starting dynamic subtest: pipe-B-eDP-1
[386.097928] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.333s)
[386.106859] Starting dynamic subtest: pipe-C-eDP-1
[390.413208] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.314s)
[390.422389] Starting dynamic subtest: pipe-D-eDP-1
[394.753862] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.341s)
[394.756393] Subtest tiling-x: SUCCESS (16.631s)
[395.587968] [091/131] (625s left) kms_frontbuffer_tracking (fbc-tiling-4)
[395.688454] Starting subtest: fbc-tiling-4
[399.917388] Subtest fbc-tiling-4: SUCCESS (4.232s)
[401.090557] [092/131] (620s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[401.195243] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[401.197466] Starting dynamic subtest: pipe-A-eDP-1
[403.171917] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.979s)
[403.179946] Starting dynamic subtest: pipe-B-eDP-1
[405.307793] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.132s)
[405.315916] Starting dynamic subtest: pipe-C-eDP-1
[407.297788] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.990s)
[407.306661] Starting dynamic subtest: pipe-D-eDP-1
[409.337655] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.036s)
[409.339969] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.143s)
[410.616107] [093/131] (610s left) prime_mmap (test_aperture_limit)
[410.683014] Starting subtest: test_aperture_limit
[410.685417] Starting dynamic subtest: test_aperture_limit-smem
[410.693663] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[410.698290] Subtest test_aperture_limit: SKIP (0.008s)
[410.828113] [094/131] (610s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[410.932168] Starting subtest: addfb25-yf-tiled-legacy
[410.934054] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[411.060954] [095/131] (610s left) perf (gen12-group-concurrent-oa-buffer-read)
[411.204101] Starting subtest: gen12-group-concurrent-oa-buffer-read
[421.244037] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.039s)
[421.297468] [096/131] (600s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[421.400464] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[421.404450] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[421.518354] [097/131] (599s left) kms_psr (pr-no-drrs)
[421.628963] Starting subtest: pr-no-drrs
[421.633263] Subtest pr-no-drrs: SKIP (0.000s)
[421.724392] [098/131] (599s left) kms_cursor_crc (cursor-offscreen-128x128)
[421.930879] Starting subtest: cursor-offscreen-128x128
[421.933130] Starting dynamic subtest: pipe-A-eDP-1
[423.853751] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.921s)
[423.882168] Starting dynamic subtest: pipe-D-eDP-1
[426.472140] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.594s)
[426.474102] Subtest cursor-offscreen-128x128: SUCCESS (4.541s)
[427.365738] [099/131] (594s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[427.464967] Starting subtest: primary-x-tiled-reflect-x-180
[434.760490] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.296s)
[436.039409] [100/131] (585s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[436.096639] Starting subtest: etime-multi-wait-for-submit-submitted
[436.202437] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s)
[436.301610] [101/131] (585s left) gem_exec_balancer (parallel-out-fence)
[436.598547] Starting subtest: parallel-out-fence
[437.674927] Subtest parallel-out-fence: SUCCESS (1.076s)
[437.797846] [102/131] (583s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[437.898323] Starting subtest: fbc-rgb101010-draw-pwrite
[443.352455] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.456s)
[444.550793] [103/131] (577s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[444.625647] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[444.630647] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[444.837317] [104/131] (576s left) i915_pm_rpm (gem-idle)
[447.078090] Starting subtest: gem-idle
[453.272751] Subtest gem-idle: SUCCESS (6.197s)
[453.617604] [105/131] (568s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[454.905219] Starting subtest: framebuffer-vs-set-tiling
[454.910183] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[455.089453] [106/131] (566s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[455.479113] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[456.303617] [107/131] (565s left) gem_pxp (verify-pxp-stale-ctx-execution)
[456.410786] Starting subtest: verify-pxp-stale-ctx-execution
[457.472697] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s)
[457.631863] [108/131] (564s left) gem_exec_whisper (basic-normal)
[457.699045] Starting subtest: basic-normal
[462.101343] Subtest basic-normal: SUCCESS (4.400s)
[462.311066] [109/131] (559s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[462.409312] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[462.411481] Starting dynamic subtest: pipe-A-eDP-1
[462.433431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[462.445246] Starting dynamic subtest: pipe-B-eDP-1
[462.465087] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[462.473363] Starting dynamic subtest: pipe-C-eDP-1
[462.492575] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[462.500535] Starting dynamic subtest: pipe-D-eDP-1
[462.520483] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[462.522621] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[464.723038] [110/131] (557s left) kms_flip (modeset-vs-vblank-race-interruptible)
[464.818360] Starting subtest: modeset-vs-vblank-race-interruptible
[464.820654] Starting dynamic subtest: A-eDP1
[469.526134] Dynamic subtest A-eDP1: SUCCESS (4.706s)
[469.537342] Starting dynamic subtest: B-eDP1
[474.156693] Dynamic subtest B-eDP1: SUCCESS (4.628s)
[474.167499] Starting dynamic subtest: C-eDP1
[478.678128] Dynamic subtest C-eDP1: SUCCESS (4.519s)
[478.688067] Starting dynamic subtest: D-eDP1
[483.213632] Dynamic subtest D-eDP1: SUCCESS (4.534s)
[483.216106] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.397s)
[484.395618] [111/131] (537s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[489.351604] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[489.354043] Starting dynamic subtest: pipe-A-eDP-1
[501.079493] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.728s)
[501.089627] Starting dynamic subtest: pipe-B-eDP-1
[512.810074] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.728s)
[512.812444] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.460s)
[513.693029] [112/131] (508s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[513.792923] Starting subtest: fbcpsr-shrfb-scaledprimary
[519.616410] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.827s)
[519.776334] [113/131] (502s left) kms_psr (fbc-psr-sprite-plane-onoff)
[519.873144] Starting subtest: fbc-psr-sprite-plane-onoff
[519.875474] Starting dynamic subtest: eDP-1
[519.879881] Dynamic subtest eDP-1: SKIP (0.000s)
[519.884249] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[519.971234] [114/131] (502s left) gem_partial_pwrite_pread (writes-after-reads)
[520.040358] Subtest writes-after-reads: SKIP (0.000s)
[520.106392] [115/131] (502s left) kms_selftest (drm_format)
[520.146141] Starting subtest: drm_format
[520.182920] Starting dynamic subtest: drm_test_format_block_width_invalid
[520.283430] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.101s)
[520.292273] Starting dynamic subtest: drm_test_format_block_width_one_plane
[520.423554] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.137s)
[520.433508] Starting dynamic subtest: drm_test_format_block_width_two_plane
[520.571237] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.148s)
[520.581145] Starting dynamic subtest: drm_test_format_block_width_three_plane
[520.721858] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.149s)
[520.731480] Starting dynamic subtest: drm_test_format_block_width_tiled
[520.862190] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.139s)
[520.871920] Starting dynamic subtest: drm_test_format_block_height_invalid
[521.001093] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.138s)
[521.011181] Starting dynamic subtest: drm_test_format_block_height_one_plane
[521.126038] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.124s)
[521.134279] Starting dynamic subtest: drm_test_format_block_height_two_plane
[521.221441] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.096s)
[521.229253] Starting dynamic subtest: drm_test_format_block_height_three_plane
[521.357354] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.133s)
[521.366443] Starting dynamic subtest: drm_test_format_block_height_tiled
[521.475116] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.117s)
[521.483406] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[521.573099] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.098s)
[521.582674] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[521.653434] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.081s)
[521.661334] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[521.749898] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.094s)
[521.768175] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[521.876839] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.125s)
[521.886987] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[522.009401] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.131s)
[522.019604] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[522.150171] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.140s)
[522.159897] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[522.263430] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.114s)
[522.273248] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[522.365262] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.102s)
[522.367537] Subtest drm_format: SUCCESS (2.219s)
[522.565375] [116/131] (499s left) kms_vblank (invalid)
[522.670078] Starting subtest: invalid
[522.671932] Starting dynamic subtest: pipe-A-eDP-1
[523.075626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s)
[523.077766] Subtest invalid: SUCCESS (0.406s)
[523.952352] [117/131] (498s left) gem_exec_reloc (basic-cpu-wc-active)
[524.015839] Subtest basic-cpu-wc-active: SKIP (0.000s)
[524.112227] [118/131] (498s left) gem_tiled_partial_pwrite_pread (reads)
[524.178126] Subtest reads: SKIP (0.000s)
[524.263991] [119/131] (498s left) kms_big_fb (linear-8bpp-rotate-180)
[524.377853] Starting subtest: linear-8bpp-rotate-180
[525.604987] Subtest linear-8bpp-rotate-180: SUCCESS (1.226s)
[525.757397] [120/131] (496s left) kms_dp_aux_dev
[526.144657] [121/131] (496s left) syncobj_eventfd (binary-wait-signaled)
[526.212904] Starting subtest: binary-wait-signaled
[526.215107] Subtest binary-wait-signaled: SUCCESS (0.000s)
[526.341847] [122/131] (496s left) gem_softpin (evict-snoop-interruptible)
[526.399210] Starting subtest: evict-snoop-interruptible
[526.404044] Subtest evict-snoop-interruptible: SKIP (0.000s)
[526.554092] [123/131] (496s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[531.685323] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[531.687746] Starting dynamic subtest: pipe-A-eDP-1
[532.494436] Dynamic subtest pipe-A-eDP-1: SKIP (0.807s)
[532.503981] Starting dynamic subtest: pipe-B-eDP-1
[533.622288] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[533.626822] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.938s)
[534.922343] [124/131] (487s left) sysfs_timeslice_duration (invalid)
[534.989224] Starting subtest: invalid
[534.991557] Starting dynamic subtest: vecs0
[534.993824] Dynamic subtest vecs0: SUCCESS (0.000s)
[535.001617] Starting dynamic subtest: ccs0
[535.003526] Dynamic subtest ccs0: SUCCESS (0.000s)
[535.011093] Starting dynamic subtest: vcs0
[535.013088] Dynamic subtest vcs0: SUCCESS (0.000s)
[535.020518] Starting dynamic subtest: bcs0
[535.022481] Dynamic subtest bcs0: SUCCESS (0.000s)
[535.030357] Starting dynamic subtest: rcs0
[535.032278] Dynamic subtest rcs0: SUCCESS (0.000s)
[535.039991] Starting dynamic subtest: vcs1
[535.041980] Dynamic subtest vcs1: SUCCESS (0.000s)
[535.043897] Subtest invalid: SUCCESS (0.005s)
[535.129855] [125/131] (487s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[535.214976] Starting subtest: fbc-psr2-sprite-mmap-cpu
[535.217303] Starting dynamic subtest: eDP-1
[535.221653] Dynamic subtest eDP-1: SKIP (0.000s)
[535.225942] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[535.323478] [126/131] (487s left) drm_read (fault-buffer)
[535.499672] Starting subtest: fault-buffer
[535.502065] Subtest fault-buffer: SUCCESS (0.000s)
[535.670447] [127/131] (487s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[535.778266] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[536.391220] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.614s)
[536.613256] [128/131] (486s left) kms_cursor_crc (cursor-sliding-128x128)
[536.834533] Starting subtest: cursor-sliding-128x128
[536.839525] Starting dynamic subtest: pipe-A-eDP-1
[540.055793] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.217s)
[540.082867] Starting dynamic subtest: pipe-D-eDP-1
[543.976304] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.901s)
[543.978570] Subtest cursor-sliding-128x128: SUCCESS (7.142s)
[544.888914] [129/131] (477s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[544.984535] Starting subtest: fbc-indfb-scaledprimary
[547.929066] Subtest fbc-indfb-scaledprimary: SUCCESS (2.949s)
[549.081522] [130/131] (473s left) kms_atomic (plane-invalid-params-fence)
[549.180674] Starting subtest: plane-invalid-params-fence
[549.182589] Starting dynamic subtest: pipe-A-eDP-1
[549.541191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s)
[549.543061] Subtest plane-invalid-params-fence: SUCCESS (0.365s)
[550.402198] [131/131] (472s left) core_setmaster (master-drop-set-shared-fd)
[550.508599] Starting subtest: master-drop-set-shared-fd
[550.527602] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[550.573918] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_ppgtt
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: i915_pm_freq_api
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_partial_pwrite_pread
results: parsing output: 10/ for test: gem_ctx_exec
results: parsing output: 11/ for test: kms_atomic_transition
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_dsc
results: parsing output: 15/ for test: kms_chamelium_color
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: gem_busy
results: parsing output: 22/ for test: gem_exec_flush
results: parsing output: 23/ for test: kms_chamelium_hpd
results: parsing output: 24/ for test: kms_lease
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_prop_blob
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_ctx_shared
results: parsing output: 31/ for test: tools_test
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: sw_sync
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: i915_selftest
results: parsing output: 39/ for test: kms_content_protection
results: parsing output: 40/ for test: gem_exec_alignment
results: parsing output: 41/ for test: api_intel_bb
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: prime_vgem
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: api_intel_allocator
results: parsing output: 49/ for test: gem_lmem_swapping
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_getfb
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: kms_atomic_interruptible
results: parsing output: 57/ for test: i915_query
results: parsing output: 58/ for test: gem_tiled_wb
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_invalid_mode
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_vrr
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_reg_read
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_create
results: parsing output: 88/ for test: kms_psr2_su
results: parsing output: 89/ for test: kms_plane_multiple
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: prime_mmap
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_rotation_crc
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: i915_pm_rpm
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_chamelium_edid
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: kms_selftest
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_dp_aux_dev
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: sysfs_timeslice_duration
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: drm_read
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_atomic
results: parsing output: 130/ for test: core_setmaster
Done.