[58.259604] Initializing watchdogs
[58.259666]   /dev/watchdog0
[58.274376] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.279249] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.281549] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.285076] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[58.405979] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[58.410594] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[58.501529] [002/133] (960s left) gem_exec_whisper (basic-fds-forked-all)
[58.564684] Starting subtest: basic-fds-forked-all
[79.863527] Subtest basic-fds-forked-all: SUCCESS (21.313s)
[80.052117] [003/133] (938s left) kms_properties (plane-properties-atomic)
[80.149842] Starting subtest: plane-properties-atomic
[80.152116] Starting dynamic subtest: pipe-A-eDP-1
[80.745650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[80.753234] Starting dynamic subtest: pipe-B-eDP-1
[81.990774] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s)
[81.998309] Starting dynamic subtest: pipe-C-eDP-1
[83.227177] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[83.234964] Starting dynamic subtest: pipe-D-eDP-1
[84.460647] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[84.462665] Subtest plane-properties-atomic: SUCCESS (4.310s)
[85.253791] [004/133] (933s left) gem_exec_schedule (fifo)
[85.322605] Starting subtest: fifo
[85.324758] Starting dynamic subtest: rcs0
[85.413730] Dynamic subtest rcs0: SUCCESS (0.101s)
[85.422906] Starting dynamic subtest: vcs0
[85.497531] Dynamic subtest vcs0: SUCCESS (0.083s)
[85.507856] Starting dynamic subtest: vcs1
[85.574326] Dynamic subtest vcs1: SUCCESS (0.077s)
[85.584452] Starting dynamic subtest: vecs0
[85.649227] Dynamic subtest vecs0: SUCCESS (0.074s)
[85.663631] Starting dynamic subtest: ccs0
[85.734098] Dynamic subtest ccs0: SUCCESS (0.084s)
[85.736538] Subtest fifo: SUCCESS (0.421s)
[87.052515] [005/133] (931s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[87.157325] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[87.159551] Starting dynamic subtest: pipe-A-eDP-1
[87.181585] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[87.192366] Starting dynamic subtest: pipe-B-eDP-1
[87.213506] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[87.220890] Starting dynamic subtest: pipe-C-eDP-1
[87.242280] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[87.249964] Starting dynamic subtest: pipe-D-eDP-1
[87.272695] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[87.277030] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[89.338397] [006/133] (929s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[89.427014] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[89.429343] Starting dynamic subtest: pipe-A-eDP-1
[89.452070] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[89.461587] Starting dynamic subtest: pipe-B-eDP-1
[89.483306] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[89.490452] Starting dynamic subtest: pipe-C-eDP-1
[89.512037] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[89.519217] Starting dynamic subtest: pipe-D-eDP-1
[89.540632] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[89.545026] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[91.710507] [007/133] (927s left) kms_psr (psr-dpms)
[91.808346] Starting subtest: psr-dpms
[91.810767] Starting dynamic subtest: eDP-1
[94.772411] Dynamic subtest eDP-1: SUCCESS (2.964s)
[94.774752] Subtest psr-dpms: SUCCESS (2.965s)
[95.623613] [008/133] (923s left) gem_exec_params (invalid-fence-in)
[95.694406] Starting subtest: invalid-fence-in
[95.696721] Subtest invalid-fence-in: SUCCESS (0.000s)
[95.799360] [009/133] (923s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[95.902985] Starting subtest: 4-tiled-32bpp-rotate-180
[97.281749] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.380s)
[97.434637] [010/133] (921s left) gem_ctx_engines (none)
[97.496895] Starting subtest: none
[97.498961] Subtest none: SUCCESS (0.002s)
[97.678552] [011/133] (921s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[97.778412] Starting subtest: y-tiled-8bpp-rotate-0
[97.783118] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[97.888276] [012/133] (921s left) gem_unref_active_buffers
[98.115090] [013/133] (921s left) gem_userptr_blits (unsync-overlap)
[98.178580] Subtest unsync-overlap: SKIP (0.000s)
[98.292703] [014/133] (920s left) perf_pmu (render-node-busy-idle)
[98.375658] Starting subtest: render-node-busy-idle
[98.378461] Starting dynamic subtest: rcs0
[99.068486] Dynamic subtest rcs0: SUCCESS (0.692s)
[99.079351] Starting dynamic subtest: bcs0
[99.732203] Dynamic subtest bcs0: SUCCESS (0.662s)
[99.743037] Starting dynamic subtest: vcs0
[100.885203] Dynamic subtest vcs0: SUCCESS (1.151s)
[100.896214] Starting dynamic subtest: vcs1
[102.932926] Dynamic subtest vcs1: SUCCESS (2.046s)
[102.941862] Starting dynamic subtest: vecs0
[104.917604] Dynamic subtest vecs0: SUCCESS (1.983s)
[104.928928] Starting dynamic subtest: ccs0
[105.581666] Dynamic subtest ccs0: SUCCESS (0.663s)
[105.584262] Subtest render-node-busy-idle: SUCCESS (7.206s)
[105.655804] [015/133] (913s left) kms_chamelium_color (ctm-0-50)
[105.769961] Subtest ctm-0-50: SKIP (0.000s)
[105.814559] [016/133] (913s left) i915_drm_fdinfo (virtual-busy-idle-all)
[105.853272] Starting subtest: virtual-busy-idle-all
[105.857810] Subtest virtual-busy-idle-all: SKIP (0.000s)
[105.913762] [017/133] (913s left) api_intel_bb (simple-bb-ctx)
[105.963154] Starting subtest: simple-bb-ctx
[105.979492] Subtest simple-bb-ctx: SUCCESS (0.017s)
[106.113769] [018/133] (913s left) prime_vgem (busy)
[106.350684] Starting subtest: busy
[106.353115] Starting dynamic subtest: rcs0
[106.389767] Dynamic subtest rcs0: SUCCESS (0.039s)
[106.397730] Starting dynamic subtest: bcs0
[106.448432] Dynamic subtest bcs0: SUCCESS (0.058s)
[106.456741] Starting dynamic subtest: vcs0
[106.494803] Dynamic subtest vcs0: SUCCESS (0.046s)
[106.502620] Starting dynamic subtest: vcs1
[106.540231] Dynamic subtest vcs1: SUCCESS (0.045s)
[106.548157] Starting dynamic subtest: vecs0
[106.585554] Dynamic subtest vecs0: SUCCESS (0.045s)
[106.593682] Starting dynamic subtest: ccs0
[106.633782] Dynamic subtest ccs0: SUCCESS (0.048s)
[106.635922] Subtest busy: SUCCESS (0.283s)
[106.747954] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[106.751082] [019/133] (912s left) dumb_buffer (create-clear)
[106.816719] Starting subtest: create-clear
[140.943095] Subtest create-clear: SUCCESS (34.123s)
[141.032618] [020/133] (878s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[141.131857] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[141.136187] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[141.203633] [021/133] (878s left) gem_exec_schedule (lateslice)
[141.269393] Starting subtest: lateslice
[141.271626] Starting dynamic subtest: rcs0
[141.279451] Dynamic subtest rcs0: SUCCESS (0.022s)
[141.289648] Starting dynamic subtest: bcs0
[141.296893] Dynamic subtest bcs0: SUCCESS (0.017s)
[141.305183] Starting dynamic subtest: vcs0
[141.317398] Dynamic subtest vcs0: SUCCESS (0.020s)
[141.325165] Starting dynamic subtest: vcs1
[141.334947] Dynamic subtest vcs1: SUCCESS (0.018s)
[141.343340] Starting dynamic subtest: vecs0
[141.352025] Dynamic subtest vecs0: SUCCESS (0.016s)
[141.359901] Starting dynamic subtest: ccs0
[141.369146] Dynamic subtest ccs0: SUCCESS (0.017s)
[141.371399] Subtest lateslice: SUCCESS (0.112s)
[143.008211] [022/133] (876s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[143.099851] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[143.102022] Starting dynamic subtest: pipe-A-eDP-1
[143.124129] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[143.134520] Starting dynamic subtest: pipe-B-eDP-1
[143.155689] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[143.163514] Starting dynamic subtest: pipe-C-eDP-1
[143.184789] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[143.192767] Starting dynamic subtest: pipe-D-eDP-1
[143.214197] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[143.218147] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.003s)
[145.381423] [023/133] (874s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[145.438154] Starting subtest: invalid-bsd2-flag-on-vebox
[145.440447] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[145.526956] [024/133] (874s left) kms_cursor_crc (cursor-random-32x32)
[145.667629] Starting subtest: cursor-random-32x32
[145.715327] Subtest cursor-random-32x32: SKIP (0.045s)
[146.000867] [025/133] (873s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[146.096271] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[152.993351] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.899s)
[153.117891] [026/133] (866s left) kms_addfb_basic (no-handle)
[153.173380] Starting subtest: no-handle
[153.176180] Subtest no-handle: SUCCESS (0.000s)
[153.300098] [027/133] (866s left) kms_flip (2x-flip-vs-panning-interruptible)
[153.389965] Starting subtest: 2x-flip-vs-panning-interruptible
[153.402057] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[153.530019] [028/133] (866s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[153.623646] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[160.218787] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.598s)
[160.354561] [029/133] (859s left) kms_lease (simple-lease)
[160.447371] Starting subtest: simple-lease
[160.449810] Starting dynamic subtest: pipe-A-eDP-1
[160.951331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.505s)
[160.960119] Starting dynamic subtest: pipe-B-eDP-1
[162.362909] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s)
[162.371586] Starting dynamic subtest: pipe-C-eDP-1
[163.771972] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.407s)
[163.779883] Starting dynamic subtest: pipe-D-eDP-1
[165.208670] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s)
[165.211060] Subtest simple-lease: SUCCESS (4.761s)
[166.017086] [030/133] (853s left) gem_render_tiled_blits (basic)
[166.081842] Subtest basic: SKIP (0.000s)
[166.149388] [031/133] (853s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[166.249734] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[172.928585] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.680s)
[173.048144] [032/133] (846s left) gem_bad_reloc (negative-reloc-lut)
[173.107689] Subtest negative-reloc-lut: SKIP (0.000s)
[173.172029] [033/133] (846s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[173.290941] Starting subtest: cursorB-vs-flipA-legacy
[173.295882] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[173.444941] [034/133] (846s left) syncobj_timeline (reset-unsignaled)
[173.510091] Starting subtest: reset-unsignaled
[173.512486] Subtest reset-unsignaled: SUCCESS (0.000s)
[173.619099] [035/133] (846s left) gem_exec_balancer (individual)
[173.694633] Starting subtest: individual
[175.893794] Subtest individual: SUCCESS (2.199s)
[176.203908] [036/133] (843s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[176.320524] Starting subtest: cursorA-vs-flipA-legacy
[187.449391] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.127s)
[188.274758] [037/133] (831s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[188.400995] Starting subtest: verify-pxp-stale-buf-optout-execution
[189.464408] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.064s)
[189.579985] [038/133] (830s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[189.632654] Starting subtest: invalid-single-wait-unsubmitted
[189.634520] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[189.727708] [039/133] (830s left) gem_lmem_swapping (heavy-verify-multi)
[189.772929] Subtest heavy-verify-multi: SKIP (0.000s)
[189.820505] [040/133] (830s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[189.915101] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[189.917631] Starting dynamic subtest: pipe-A-eDP-1
[190.008649] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[190.018547] Starting dynamic subtest: pipe-B-eDP-1
[191.159083] Dynamic subtest pipe-B-eDP-1: SKIP (1.147s)
[191.163617] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.250s)
[192.351302] [041/133] (828s left) kms_rotation_crc (primary-rotation-90)
[192.444371] Starting subtest: primary-rotation-90
[192.448776] Subtest primary-rotation-90: SKIP (0.001s)
[192.530301] [042/133] (827s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[192.622418] Starting subtest: fbc-rgb101010-draw-pwrite
[198.027218] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.406s)
[199.149738] [043/133] (821s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[199.253566] Starting subtest: psr-2p-pri-indfb-multidraw
[199.257634] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[199.357897] [044/133] (821s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[199.468564] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[199.472696] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[199.577815] [045/133] (820s left) syncobj_wait (reset-multiple-signaled)
[199.638044] Starting subtest: reset-multiple-signaled
[199.640398] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[199.736144] [046/133] (820s left) perf (global-sseu-config-invalid)
[199.866038] Starting subtest: global-sseu-config-invalid
[199.870334] Subtest global-sseu-config-invalid: SKIP (0.000s)
[199.907995] [047/133] (820s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[200.005538] Starting subtest: x-tiled-32bpp-rotate-0
[201.373721] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.368s)
[201.510742] [048/133] (819s left) gem_exec_flush (basic-wb-ro-before-default)
[201.574856] Starting subtest: basic-wb-ro-before-default
[207.036235] Subtest basic-wb-ro-before-default: SUCCESS (5.460s)
[207.222746] [049/133] (813s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[207.321718] Starting subtest: plane-ctm3x4-lut1d
[207.467919] Starting dynamic subtest: pipe-A-plane-0
[207.827175] Dynamic subtest pipe-A-plane-0: FAIL (0.197s)
[207.839237] Starting dynamic subtest: pipe-A-plane-1
[208.049732] Dynamic subtest pipe-A-plane-1: FAIL (0.166s)
[208.059238] Starting dynamic subtest: pipe-A-plane-2
[208.279044] Dynamic subtest pipe-A-plane-2: FAIL (0.165s)
[209.270578] Starting dynamic subtest: pipe-B-plane-0
[209.717232] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[209.726068] Starting dynamic subtest: pipe-B-plane-1
[210.046390] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[210.055054] Starting dynamic subtest: pipe-B-plane-2
[210.340364] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[210.982820] Starting dynamic subtest: pipe-C-plane-0
[211.486140] Dynamic subtest pipe-C-plane-0: FAIL (0.152s)
[211.497748] Starting dynamic subtest: pipe-C-plane-1
[211.880037] Dynamic subtest pipe-C-plane-1: FAIL (0.166s)
[211.889803] Starting dynamic subtest: pipe-C-plane-2
[212.239480] Dynamic subtest pipe-C-plane-2: FAIL (0.620s)
[213.096569] Starting dynamic subtest: pipe-D-plane-0
[213.715567] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[213.724762] Starting dynamic subtest: pipe-D-plane-1
[214.166090] Dynamic subtest pipe-D-plane-1: FAIL (0.608s)
[214.174861] Starting dynamic subtest: pipe-D-plane-2
[214.624338] Dynamic subtest pipe-D-plane-2: FAIL (0.560s)
[214.719194] Subtest plane-ctm3x4-lut1d: FAIL (7.397s)
[215.573194] [050/133] (805s left) kms_cursor_crc (cursor-onscreen-max-size)
[215.886296] Starting subtest: cursor-onscreen-max-size
[215.892697] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[216.009637] [051/133] (804s left) kms_flip (2x-plain-flip-fb-recreate)
[216.106832] Starting subtest: 2x-plain-flip-fb-recreate
[216.130882] Subtest 2x-plain-flip-fb-recreate: SKIP (0.023s)
[216.220810] [052/133] (804s left) i915_pm_sseu (full-enable)
[216.275822] Subtest full-enable: SKIP (0.000s)
[216.380599] [053/133] (804s left) kms_vblank (wait-idle)
[216.475757] Starting subtest: wait-idle
[216.477529] Starting dynamic subtest: pipe-A-eDP-1
[218.233623] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.758s)
[218.245710] Starting dynamic subtest: pipe-D-eDP-1
[220.722053] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.484s)
[220.723998] Subtest wait-idle: SUCCESS (4.246s)
[221.538360] [054/133] (799s left) gem_ctx_isolation (nonpriv)
[221.604579] Starting subtest: nonpriv
[221.607011] Starting dynamic subtest: rcs0
[221.834902] Dynamic subtest rcs0: SUCCESS (0.230s)
[221.845438] Starting dynamic subtest: bcs0
[222.094680] Dynamic subtest bcs0: SUCCESS (0.259s)
[222.104720] Starting dynamic subtest: vcs0
[222.350899] Dynamic subtest vcs0: SUCCESS (0.255s)
[222.360450] Starting dynamic subtest: vcs1
[224.122817] Dynamic subtest vcs1: SUCCESS (1.770s)
[224.136929] Starting dynamic subtest: vecs0
[226.188778] Dynamic subtest vecs0: SUCCESS (2.064s)
[226.197226] Starting dynamic subtest: ccs0
[228.122047] Dynamic subtest ccs0: SUCCESS (1.932s)
[228.124301] Subtest nonpriv: SUCCESS (6.518s)
[228.365520] [055/133] (792s left) syncobj_timeline (wait-delayed-signal)
[228.431494] Starting subtest: wait-delayed-signal
[228.533257] Subtest wait-delayed-signal: SUCCESS (0.103s)
[228.642521] [056/133] (792s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[228.754959] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[228.759206] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[228.827959] [057/133] (792s left) kms_pm_rpm (pm-tiling)
[231.073905] Starting subtest: pm-tiling
[231.079150] Subtest pm-tiling: SKIP (0.000s)
[231.480387] [058/133] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[231.579844] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[239.064187] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.488s)
[239.175555] [059/133] (781s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[239.273754] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[239.275945] Starting dynamic subtest: pipe-A-default-mode
[242.028951] Dynamic subtest pipe-A-default-mode: SUCCESS (2.753s)
[242.031156] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.755s)
[242.874577] [060/133] (778s left) kms_pm_rpm (basic-pci-d3-state)
[245.008902] Starting subtest: basic-pci-d3-state
[246.475672] Subtest basic-pci-d3-state: SUCCESS (1.466s)
[246.568307] [061/133] (774s left) kms_busy (extended-modeset-hang-newfb)
[246.659865] Starting subtest: extended-modeset-hang-newfb
[246.661710] Starting dynamic subtest: pipe-A
[280.883762] Dynamic subtest pipe-A: SUCCESS (34.221s)
[280.893609] Starting dynamic subtest: pipe-D
[303.768193] Dynamic subtest pipe-D: SUCCESS (22.883s)
[303.770472] Subtest extended-modeset-hang-newfb: SUCCESS (57.108s)
[304.587236] [062/133] (716s left) gen9_exec_parse (bb-start-param)
[304.662051] Subtest bb-start-param: SKIP (0.000s)
[304.724776] [063/133] (716s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[304.830104] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[304.834069] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[304.924570] [064/133] (716s left) gem_exec_async (forked-writes)
[304.984671] Starting subtest: forked-writes
[304.986867] Starting dynamic subtest: rcs0
[305.014199] Dynamic subtest rcs0: SUCCESS (0.029s)
[305.024066] Starting dynamic subtest: bcs0
[305.038506] Dynamic subtest bcs0: SUCCESS (0.023s)
[305.050178] Starting dynamic subtest: vcs0
[305.061318] Dynamic subtest vcs0: SUCCESS (0.022s)
[305.070053] Starting dynamic subtest: vcs1
[305.084181] Dynamic subtest vcs1: SUCCESS (0.022s)
[305.093096] Starting dynamic subtest: vecs0
[305.108235] Dynamic subtest vecs0: SUCCESS (0.023s)
[305.116975] Starting dynamic subtest: ccs0
[305.131077] Dynamic subtest ccs0: SUCCESS (0.022s)
[305.133275] Subtest forked-writes: SUCCESS (0.147s)
[305.361961] [065/133] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[305.470288] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[305.474228] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[305.568164] [066/133] (715s left) api_intel_bb (crc32)
[305.628089] Starting subtest: crc32
[305.630568] Starting dynamic subtest: rcs0-smem0
[305.935276] Dynamic subtest rcs0-smem0: SUCCESS (0.308s)
[305.947324] Starting dynamic subtest: bcs0-smem0
[306.298362] Dynamic subtest bcs0-smem0: SUCCESS (0.360s)
[306.308724] Starting dynamic subtest: vcs0-smem0
[306.615255] Dynamic subtest vcs0-smem0: SUCCESS (0.314s)
[306.627748] Starting dynamic subtest: vcs1-smem0
[306.975225] Dynamic subtest vcs1-smem0: SUCCESS (0.357s)
[306.986948] Starting dynamic subtest: vecs0-smem0
[307.374341] Dynamic subtest vecs0-smem0: SUCCESS (0.396s)
[307.389099] Starting dynamic subtest: ccs0-smem0
[307.731030] Dynamic subtest ccs0-smem0: SUCCESS (0.354s)
[307.733801] Subtest crc32: SUCCESS (2.106s)
[307.844727] [067/133] (713s left) kms_flip (flip-vs-dpms-on-nop)
[307.932088] Starting subtest: flip-vs-dpms-on-nop
[307.934351] Starting dynamic subtest: A-eDP1
[309.862094] Dynamic subtest A-eDP1: SUCCESS (1.928s)
[309.872578] Starting dynamic subtest: B-eDP1
[311.681446] Dynamic subtest B-eDP1: SUCCESS (1.817s)
[311.695053] Starting dynamic subtest: C-eDP1
[313.605572] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[313.615216] Starting dynamic subtest: D-eDP1
[315.434526] Dynamic subtest D-eDP1: SUCCESS (1.827s)
[315.436933] Subtest flip-vs-dpms-on-nop: SUCCESS (7.505s)
[316.642531] [068/133] (704s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[316.737297] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[316.741525] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[316.836188] [069/133] (704s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[316.929093] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[316.933549] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[317.055186] [070/133] (704s left) vgem_basic (setversion)
[317.096059] Starting subtest: setversion
[317.100043] Subtest setversion: SUCCESS (0.000s)
[317.166870] [071/133] (704s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[317.274682] Starting subtest: basic-busy-flip-before-cursor-varying-size
[317.279280] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[317.420232] [072/133] (704s left) sw_sync (alloc_fence_invalid_timeline)
[317.461304] Starting subtest: alloc_fence_invalid_timeline
[317.463690] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[317.521127] [073/133] (704s left) kms_atomic (plane-invalid-params-fence)
[317.607598] Starting subtest: plane-invalid-params-fence
[317.609410] Starting dynamic subtest: pipe-A-eDP-1
[317.976910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.368s)
[317.978902] Subtest plane-invalid-params-fence: SUCCESS (0.369s)
[318.771665] [074/133] (702s left) kms_big_fb (linear-16bpp-rotate-180)
[318.868658] Starting subtest: linear-16bpp-rotate-180
[320.158195] Subtest linear-16bpp-rotate-180: SUCCESS (1.289s)
[320.304045] [075/133] (701s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[320.394358] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[320.396311] Starting dynamic subtest: pipe-A
[321.611080] Dynamic subtest pipe-A: SUCCESS (1.218s)
[321.619093] Starting dynamic subtest: pipe-B
[323.920920] Dynamic subtest pipe-B: SUCCESS (2.308s)
[323.930661] Starting dynamic subtest: pipe-C
[325.087216] Dynamic subtest pipe-C: SUCCESS (1.165s)
[325.098475] Starting dynamic subtest: pipe-D
[326.337586] Dynamic subtest pipe-D: SUCCESS (1.247s)
[326.340037] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.945s)
[327.527316] [076/133] (694s left) gem_eio (in-flight-immediate)
[327.771123] Starting subtest: in-flight-immediate
[335.707332] Subtest in-flight-immediate: SUCCESS (7.935s)
[335.829422] [077/133] (686s left) gem_wait (await)
[335.894329] Starting subtest: await
[335.896600] Starting dynamic subtest: all-engines
[337.007489] Dynamic subtest all-engines: SUCCESS (1.116s)
[337.026299] Starting dynamic subtest: rcs0
[338.065841] Dynamic subtest rcs0: SUCCESS (1.055s)
[338.082042] Starting dynamic subtest: bcs0
[339.121805] Dynamic subtest bcs0: SUCCESS (1.053s)
[339.138057] Starting dynamic subtest: vcs0
[340.175621] Dynamic subtest vcs0: SUCCESS (1.052s)
[340.192644] Starting dynamic subtest: vcs1
[341.227553] Dynamic subtest vcs1: SUCCESS (1.050s)
[341.244788] Starting dynamic subtest: vecs0
[342.281747] Dynamic subtest vecs0: SUCCESS (1.052s)
[342.298532] Starting dynamic subtest: ccs0
[343.340057] Dynamic subtest ccs0: SUCCESS (1.055s)
[343.342968] Subtest await: SUCCESS (7.449s)
[343.540645] [078/133] (678s left) syncobj_timeline (host-signal-ordered)
[343.602483] Starting subtest: host-signal-ordered
[343.604753] Subtest host-signal-ordered: SUCCESS (0.001s)
[343.697365] [079/133] (678s left) syncobj_basic (bad-pad-handle-to-fd)
[343.762544] Starting subtest: bad-pad-handle-to-fd
[343.764509] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[343.853239] [080/133] (678s left) kms_chamelium_frames (hdmi-aspect-ratio)
[344.249163] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[345.038902] [081/133] (676s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[345.127706] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[345.130032] Starting dynamic subtest: pipe-A
[345.190131] Dynamic subtest pipe-A: SUCCESS (0.065s)
[345.200961] Starting dynamic subtest: pipe-B
[346.384013] Dynamic subtest pipe-B: SUCCESS (1.192s)
[346.395400] Starting dynamic subtest: pipe-C
[347.506901] Dynamic subtest pipe-C: SUCCESS (1.121s)
[347.521488] Starting dynamic subtest: pipe-D
[348.624746] Dynamic subtest pipe-D: SUCCESS (1.117s)
[348.626887] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.500s)
[349.791142] [082/133] (672s left) kms_flip (2x-blocking-wf_vblank)
[349.886223] Starting subtest: 2x-blocking-wf_vblank
[349.897437] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[349.993264] [083/133] (672s left) kms_atomic_interruptible (legacy-cursor)
[350.082518] Starting subtest: legacy-cursor
[350.084798] Starting dynamic subtest: pipe-A-eDP-1
[357.519270] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.434s)
[357.521487] Subtest legacy-cursor: SUCCESS (7.436s)
[358.375757] [084/133] (663s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[358.482371] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[358.510963] Starting dynamic subtest: pipe-A-plane-0
[358.941812] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[358.950949] Starting dynamic subtest: pipe-A-plane-3
[359.197338] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[360.344675] Starting dynamic subtest: pipe-B-plane-0
[360.814816] Dynamic subtest pipe-B-plane-0: SUCCESS (0.478s)
[360.826939] Starting dynamic subtest: pipe-B-plane-3
[361.071588] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[361.387699] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.906s)
[362.220626] [085/133] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[362.315527] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[369.406276] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.094s)
[369.518423] [086/133] (652s left) gem_mmap_wc (fault-concurrent)
[369.570206] Subtest fault-concurrent: SKIP (0.000s)
[369.635842] [087/133] (652s left) kms_psr (fbc-psr-cursor-plane-move)
[369.718303] Starting subtest: fbc-psr-cursor-plane-move
[369.720208] Starting dynamic subtest: eDP-1
[369.724270] Dynamic subtest eDP-1: SKIP (0.000s)
[369.728375] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[369.809159] [088/133] (652s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[369.901924] Starting subtest: primary-y-tiled-reflect-x-180
[369.961698] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[370.074508] [089/133] (652s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[370.165735] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[370.169762] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[370.233455] [090/133] (652s left) gem_spin_batch (resubmit-new)
[370.286801] Starting subtest: resubmit-new
[370.289161] Starting dynamic subtest: rcs0
[370.295353] Dynamic subtest rcs0: SUCCESS (0.008s)
[370.305259] Starting dynamic subtest: bcs0
[370.307615] Dynamic subtest bcs0: SUCCESS (0.004s)
[370.316656] Starting dynamic subtest: vcs0
[370.318580] Dynamic subtest vcs0: SUCCESS (0.004s)
[370.327556] Starting dynamic subtest: vcs1
[370.329690] Dynamic subtest vcs1: SUCCESS (0.004s)
[370.338100] Starting dynamic subtest: vecs0
[370.339863] Dynamic subtest vecs0: SUCCESS (0.004s)
[370.348051] Starting dynamic subtest: ccs0
[370.349903] Dynamic subtest ccs0: SUCCESS (0.007s)
[370.351855] Subtest resubmit-new: SUCCESS (0.036s)
[371.989392] [091/133] (650s left) kms_cursor_legacy (torture-move)
[372.108744] Starting subtest: torture-move
[372.111072] Starting dynamic subtest: pipe-A
[378.211654] Dynamic subtest pipe-A: SUCCESS (6.098s)
[378.223273] Starting dynamic subtest: pipe-B
[385.338308] Dynamic subtest pipe-B: SUCCESS (7.127s)
[385.349231] Starting dynamic subtest: pipe-C
[391.354277] Dynamic subtest pipe-C: SUCCESS (6.014s)
[391.368012] Starting dynamic subtest: pipe-D
[398.268888] Dynamic subtest pipe-D: SUCCESS (6.912s)
[398.279810] Starting dynamic subtest: all-pipes
[405.244909] Dynamic subtest all-pipes: SUCCESS (6.970s)
[405.247283] Subtest torture-move: SUCCESS (33.130s)
[405.398416] [092/133] (617s left) gem_tiled_partial_pwrite_pread (reads)
[405.463419] Subtest reads: SKIP (0.000s)
[405.544139] [093/133] (616s left) gem_mmap_gtt (hang-user)
[405.595019] Subtest hang-user: SKIP (0.000s)
[405.654623] [094/133] (616s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[406.033305] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[406.838819] [095/133] (615s left) gen9_exec_parse (valid-registers)
[406.902232] Subtest valid-registers: SKIP (0.000s)
[406.957622] [096/133] (615s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[407.046264] Starting subtest: compare-crc-sanitycheck-nv12
[407.048194] Starting dynamic subtest: pipe-A-eDP-1
[407.766906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[407.776829] Starting dynamic subtest: pipe-B-eDP-1
[409.074069] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.308s)
[409.084398] Starting dynamic subtest: pipe-C-eDP-1
[410.360187] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.283s)
[410.370546] Starting dynamic subtest: pipe-D-eDP-1
[411.559126] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s)
[411.561505] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.514s)
[412.392738] [097/133] (610s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[412.486486] Starting subtest: crc-primary-suspend-y-tiled-ccs
[412.488810] Starting dynamic subtest: pipe-A-eDP-1
[412.498141] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[412.509361] Starting dynamic subtest: pipe-B-eDP-1
[412.518070] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[412.526513] Starting dynamic subtest: pipe-C-eDP-1
[412.534979] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[412.543666] Starting dynamic subtest: pipe-D-eDP-1
[412.552076] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[412.556212] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[414.746410] [098/133] (607s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[414.846590] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[420.182069] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.338s)
[421.360860] [099/133] (601s left) syncobj_eventfd (timeline-wait)
[421.426235] Starting subtest: timeline-wait
[421.435643] Subtest timeline-wait: SUCCESS (0.011s)
[421.513861] [100/133] (601s left) syncobj_wait (single-wait-all-for-submit-submitted)
[421.564112] Starting subtest: single-wait-all-for-submit-submitted
[421.672779] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[421.749176] [101/133] (601s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[421.846890] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[428.564708] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.719s)
[428.676434] [102/133] (594s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[428.779478] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[428.781767] Starting dynamic subtest: pipe-A-eDP-1
[428.840493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[429.146010] Starting dynamic subtest: pipe-B-eDP-1
[429.948486] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.811s)
[430.256678] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.479s)
[431.120967] [103/133] (591s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[431.218071] Starting subtest: fbc-rgb565-draw-blt
[435.349902] Subtest fbc-rgb565-draw-blt: SUCCESS (4.135s)
[436.523581] [104/133] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[436.620231] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[436.624736] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[436.733544] [105/133] (586s left) kms_psr (pr-cursor-mmap-gtt)
[436.817388] Starting subtest: pr-cursor-mmap-gtt
[436.821607] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[436.887181] [106/133] (586s left) kms_addfb_basic (bad-pitch-1024)
[436.937125] Starting subtest: bad-pitch-1024
[436.939014] Subtest bad-pitch-1024: SUCCESS (0.000s)
[437.087955] [107/133] (586s left) gem_workarounds (suspend-resume-fd)
[437.154231] Starting subtest: suspend-resume-fd
[453.891676] Subtest suspend-resume-fd: SUCCESS (1.700s)
[461.035493] [108/133] (569s left) gem_exec_reloc (basic-wc-cpu-active)
[461.109592] Subtest basic-wc-cpu-active: SKIP (0.000s)
[461.181516] [109/133] (569s left) gem_mmap_offset (pf-nonblock)
[461.232785] Starting subtest: pf-nonblock
[461.240691] Subtest pf-nonblock: SUCCESS (0.010s)
[461.364979] [110/133] (568s left) gem_linear_blits (interruptible)
[461.899530] Starting subtest: interruptible
[467.005351] Subtest interruptible: SUCCESS (5.142s)
[467.139968] [111/133] (563s left) i915_pm_rpm (system-suspend-devices)
[469.139632] Starting subtest: system-suspend-devices
[476.796896] Subtest system-suspend-devices: SUCCESS (7.680s)
[488.215274] [112/133] (553s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[488.327794] Starting subtest: yf-tiled-16bpp-rotate-0
[488.332274] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[488.419975] [113/133] (552s left) gem_exec_fence (invalid-timeline-fence-array)
[488.988250] Starting subtest: invalid-timeline-fence-array
[488.995718] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[490.025023] [114/133] (551s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[490.146731] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[490.151845] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[490.332364] [115/133] (551s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[490.435836] Starting subtest: addfb25-y-tiled-small-legacy
[490.440003] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[490.536615] [116/133] (551s left) gem_exec_schedule (semaphore-user)
[490.616213] Starting subtest: semaphore-user
[490.673674] Subtest semaphore-user: SUCCESS (0.062s)
[491.965750] [117/133] (549s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[492.051884] Starting subtest: fbc-pr-sprite-mmap-gtt
[492.055856] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[492.129400] [118/133] (549s left) kms_vblank (accuracy-idle)
[492.219451] Starting subtest: accuracy-idle
[492.221586] Starting dynamic subtest: pipe-A-eDP-1
[493.992336] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.772s)
[494.007722] Starting dynamic subtest: pipe-D-eDP-1
[496.404816] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.408s)
[496.406775] Subtest accuracy-idle: SUCCESS (4.183s)
[497.225460] [119/133] (544s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[497.287729] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[497.292009] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[497.468911] [120/133] (544s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[497.513072] Starting subtest: wait-all-for-submit-delayed-submit
[497.618436] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[497.693538] [121/133] (544s left) prime_mmap (test_reprime)
[497.754193] Starting subtest: test_reprime
[497.756292] Starting dynamic subtest: test_reprime-smem
[497.786279] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[497.788410] Subtest test_reprime: SUCCESS (0.033s)
[497.887279] [122/133] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[497.994789] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[497.999327] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[498.094355] [123/133] (543s left) gem_mmap_gtt (cpuset-big-copy-odd)
[498.149752] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[498.212879] [124/133] (543s left) syncobj_timeline (signal-point-0)
[498.271850] Starting subtest: signal-point-0
[498.274180] Subtest signal-point-0: SUCCESS (0.000s)
[498.380065] [125/133] (543s left) gem_exec_balancer (parallel-keep-in-fence)
[498.642459] Starting subtest: parallel-keep-in-fence
[499.817225] Subtest parallel-keep-in-fence: SUCCESS (1.175s)
[499.929091] [126/133] (542s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[500.031829] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[500.034113] Starting dynamic subtest: pipe-A-eDP-1
[516.497341] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.471s)
[516.509408] Starting dynamic subtest: pipe-B-eDP-1
[533.711020] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.217s)
[533.713436] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.691s)
[534.502763] [127/133] (507s left) gem_ctx_persistence (smoketest)
[534.558964] Starting subtest: smoketest
[574.897505] Subtest smoketest: SUCCESS (40.351s)
[574.980866] [128/133] (467s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[575.096273] Starting subtest: basic-busy-flip-before-cursor-legacy
[575.100853] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[575.242119] [129/133] (466s left) kms_invalid_mode (bad-vsync-start)
[575.336417] Starting subtest: bad-vsync-start
[575.338763] Starting dynamic subtest: pipe-A-eDP-1
[575.628842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[575.641779] Starting dynamic subtest: pipe-B-eDP-1
[575.643741] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[575.654829] Starting dynamic subtest: pipe-C-eDP-1
[575.657089] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[575.667116] Starting dynamic subtest: pipe-D-eDP-1
[575.669545] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[575.671926] Subtest bad-vsync-start: SUCCESS (0.303s)
[576.421931] [130/133] (465s left) kms_feature_discovery (display-2x)
[576.507954] Starting subtest: display-2x
[576.512270] Subtest display-2x: SKIP (0.000s)
[576.579288] [131/133] (465s left) kms_psr (psr2-primary-blt)
[576.679517] Starting subtest: psr2-primary-blt
[576.681817] Starting dynamic subtest: eDP-1
[578.413175] Dynamic subtest eDP-1: SUCCESS (1.734s)
[578.415410] Subtest psr2-primary-blt: SUCCESS (1.735s)
[579.299631] [132/133] (462s left) perf (i915-ref-count)
[579.397250] Starting subtest: i915-ref-count
[579.434266] Subtest i915-ref-count: SUCCESS (0.034s)
[579.491358] [133/133] (462s left) kms_content_protection (dp-mst-type-0)
[579.636440] Starting subtest: dp-mst-type-0
[579.640860] Subtest dp-mst-type-0: SKIP (0.000s)
[579.749114] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: kms_properties
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_ctx_engines
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_unref_active_buffers
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: kms_chamelium_color
results: parsing output: 15/ for test: i915_drm_fdinfo
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: prime_vgem
results: parsing output: 18/ for test: dumb_buffer
results: parsing output: 19/ for test: kms_flip_scaled_crc
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: gem_render_tiled_blits
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_bad_reloc
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: gem_pxp
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: perf
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_flush
results: parsing output: 48/ for test: kms_color_pipeline
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: i915_pm_sseu
results: parsing output: 52/ for test: kms_vblank
results: parsing output: 53/ for test: gem_ctx_isolation
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: kms_busy
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_async
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: api_intel_bb
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: vgem_basic
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: sw_sync
results: parsing output: 72/ for test: kms_atomic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: gem_wait
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: syncobj_basic
results: parsing output: 79/ for test: kms_chamelium_frames
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_atomic_interruptible
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_mmap_wc
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: gen9_exec_parse
results: parsing output: 95/ for test: kms_pipe_crc_basic
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_eventfd
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: gem_workarounds
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: gem_linear_blits
results: parsing output: 110/ for test: i915_pm_rpm
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_vblank
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: prime_mmap
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_invalid_mode
results: parsing output: 129/ for test: kms_feature_discovery
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: kms_content_protection
Done.