[57.750788] Initializing watchdogs
[57.750848]   /dev/watchdog0
[57.765646] [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.770151] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.772586] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.776001] [001/133] (960s left) kms_addfb_basic (legacy-format)
[57.857891] Starting subtest: legacy-format
[57.883407] Subtest legacy-format: SUCCESS (0.023s)
[58.018956] [002/133] (960s left) gem_mmap_gtt (fault-concurrent)
[58.072685] Subtest fault-concurrent: SKIP (0.000s)
[58.143856] [003/133] (960s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[58.245851] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[58.250336] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[58.321687] [004/133] (960s left) gem_ctx_persistence (engines-mixed)
[58.386362] Starting subtest: engines-mixed
[58.388647] Starting dynamic subtest: rcs0
[58.486631] Dynamic subtest rcs0: SUCCESS (0.100s)
[58.497184] Starting dynamic subtest: bcs0
[58.556418] Dynamic subtest bcs0: SUCCESS (0.068s)
[58.568603] Starting dynamic subtest: vcs0
[58.614594] Dynamic subtest vcs0: SUCCESS (0.057s)
[58.623722] Starting dynamic subtest: vcs1
[58.668697] Dynamic subtest vcs1: SUCCESS (0.053s)
[58.678218] Starting dynamic subtest: vecs0
[58.734359] Dynamic subtest vecs0: SUCCESS (0.065s)
[58.743957] Starting dynamic subtest: ccs0
[58.792347] Dynamic subtest ccs0: SUCCESS (0.057s)
[58.794847] Subtest engines-mixed: SUCCESS (0.404s)
[58.872476] [005/133] (959s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[58.933320] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[58.936783] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[59.113655] [006/133] (959s left) i915_pm_rc6_residency (rc6-fence)
[59.170701] Starting subtest: rc6-fence
[59.196410] Starting dynamic subtest: gt0
[71.551941] Dynamic subtest gt0: SUCCESS (12.319s)
[71.560651] Starting dynamic subtest: gt1
[85.850608] Dynamic subtest gt1: SUCCESS (14.285s)
[85.853406] Subtest rc6-fence: SUCCESS (26.634s)
[85.925037] [007/133] (932s left) kms_flip (blocking-absolute-wf_vblank)
[86.021117] Starting subtest: blocking-absolute-wf_vblank
[86.023396] Starting dynamic subtest: A-eDP1
[94.792500] Dynamic subtest A-eDP1: SUCCESS (8.767s)
[94.802918] Starting dynamic subtest: B-eDP1
[103.522157] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[103.532584] Starting dynamic subtest: C-eDP1
[112.247879] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[112.258837] Starting dynamic subtest: D-eDP1
[120.979508] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[120.984644] Subtest blocking-absolute-wf_vblank: SUCCESS (34.954s)
[122.187570] [008/133] (896s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[122.316881] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[123.306252] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.986s)
[124.135692] [009/133] (894s left) kms_async_flips (test-cursor-atomic)
[124.221050] Starting subtest: test-cursor-atomic
[124.600296] Starting dynamic subtest: pipe-A-eDP-1
[125.424303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[125.794685] Starting dynamic subtest: pipe-B-eDP-1
[126.558219] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.770s)
[126.948275] Starting dynamic subtest: pipe-C-eDP-1
[127.694562] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[128.057325] Starting dynamic subtest: pipe-D-eDP-1
[128.830190] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[128.832503] Subtest test-cursor-atomic: SUCCESS (4.610s)
[129.994130] [010/133] (888s left) gem_lmem_swapping (basic)
[130.042029] Subtest basic: SKIP (0.000s)
[130.083568] [011/133] (888s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[130.181688] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[130.183972] Starting dynamic subtest: pipe-A-eDP-1
[146.670988] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.488s)
[146.679322] Starting dynamic subtest: pipe-B-eDP-1
[163.884049] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.213s)
[163.886281] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.704s)
[164.775014] [012/133] (853s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[164.879722] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[164.882086] Starting dynamic subtest: pipe-A-eDP-1
[165.318770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[165.331913] Starting dynamic subtest: pipe-B-eDP-1
[165.351965] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[165.361664] Starting dynamic subtest: pipe-C-eDP-1
[165.380521] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[165.388322] Starting dynamic subtest: pipe-D-eDP-1
[165.407716] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[165.410369] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.456s)
[167.625280] [013/133] (851s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[167.728590] Starting subtest: psr-rgb101010-draw-mmap-gtt
[167.732897] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[167.808893] [014/133] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[167.907942] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[167.912265] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[167.999494] [015/133] (850s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[168.103198] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[168.107186] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[168.203873] [016/133] (850s left) prime_vgem (fence-wait)
[168.331858] Starting subtest: fence-wait
[168.334083] Starting dynamic subtest: rcs0
[169.373853] Dynamic subtest rcs0: SUCCESS (1.042s)
[169.382842] Starting dynamic subtest: bcs0
[170.424983] Dynamic subtest bcs0: SUCCESS (1.051s)
[170.434496] Starting dynamic subtest: vcs0
[171.468057] Dynamic subtest vcs0: SUCCESS (1.041s)
[171.479259] Starting dynamic subtest: vcs1
[172.510506] Dynamic subtest vcs1: SUCCESS (1.040s)
[172.520589] Starting dynamic subtest: vecs0
[173.556527] Dynamic subtest vecs0: SUCCESS (1.044s)
[173.567681] Starting dynamic subtest: ccs0
[174.601532] Dynamic subtest ccs0: SUCCESS (1.043s)
[174.604660] Subtest fence-wait: SUCCESS (6.271s)
[174.730765] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[174.734336] [017/133] (844s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[174.795967] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[174.798340] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[174.939501] [018/133] (844s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[175.034902] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[175.037106] Starting dynamic subtest: pipe-A-default-mode
[177.775306] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[177.777711] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.743s)
[178.613135] [019/133] (840s left) kms_cursor_legacy (single-bo)
[178.733064] Starting subtest: single-bo
[178.735247] Starting dynamic subtest: pipe-A
[184.118286] Dynamic subtest pipe-A: SUCCESS (5.381s)
[184.128659] Starting dynamic subtest: pipe-B
[189.502260] Dynamic subtest pipe-B: SUCCESS (5.381s)
[189.512067] Starting dynamic subtest: pipe-C
[194.884915] Dynamic subtest pipe-C: SUCCESS (5.380s)
[194.895276] Starting dynamic subtest: pipe-D
[200.267754] Dynamic subtest pipe-D: SUCCESS (5.381s)
[200.278322] Starting dynamic subtest: all-pipes
[205.658945] Dynamic subtest all-pipes: SUCCESS (5.388s)
[205.661642] Subtest single-bo: SUCCESS (26.922s)
[205.798194] [020/133] (813s left) gem_exec_capture (capture-invisible)
[205.858152] Starting subtest: capture-invisible
[205.860057] Starting dynamic subtest: smem0
[205.864136] Dynamic subtest smem0: SKIP (0.000s)
[205.868225] Subtest capture-invisible: SKIP (0.001s)
[205.947762] [021/133] (813s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[206.057182] Starting subtest: 2x-flip-vs-cursor-atomic
[206.061734] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[206.200809] [022/133] (812s left) gem_ctx_shared (q-promotion)
[206.257351] Starting subtest: Q-promotion
[206.259717] Starting dynamic subtest: rcs0
[206.355455] Dynamic subtest rcs0: SUCCESS (0.097s)
[206.371336] Starting dynamic subtest: vcs0
[206.454814] Dynamic subtest vcs0: SUCCESS (0.098s)
[206.468830] Starting dynamic subtest: vcs1
[206.542233] Dynamic subtest vcs1: SUCCESS (0.087s)
[206.557612] Starting dynamic subtest: vecs0
[206.616844] Dynamic subtest vecs0: SUCCESS (0.073s)
[206.631247] Starting dynamic subtest: ccs0
[206.708707] Dynamic subtest ccs0: SUCCESS (0.092s)
[206.711032] Subtest Q-promotion: SUCCESS (0.452s)
[207.988819] [023/133] (811s left) gem_ppgtt (flink-and-close-vma-leak)
[208.063797] Starting subtest: flink-and-close-vma-leak
[208.104096] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[208.229502] [024/133] (811s left) kms_prop_blob (invalid-set-prop)
[208.283831] Starting subtest: invalid-set-prop
[208.286053] Subtest invalid-set-prop: SUCCESS (0.000s)
[208.378782] [025/133] (810s left) syncobj_basic (test-valid-cycle)
[208.430485] Starting subtest: test-valid-cycle
[208.432573] Subtest test-valid-cycle: SUCCESS (0.000s)
[208.522549] [026/133] (810s left) kms_frontbuffer_tracking (fbc-stridechange)
[208.620695] Starting subtest: fbc-stridechange
[211.891804] Subtest fbc-stridechange: SUCCESS (3.274s)
[213.022954] [027/133] (806s left) gem_ctx_persistence (legacy-engines-persistence)
[213.089743] Starting subtest: legacy-engines-persistence
[213.092324] Starting dynamic subtest: render
[213.918991] Dynamic subtest render: SUCCESS (0.828s)
[213.930769] Starting dynamic subtest: bsd1
[214.676819] Dynamic subtest bsd1: SUCCESS (0.755s)
[214.687525] Starting dynamic subtest: bsd2
[215.450077] Dynamic subtest bsd2: SUCCESS (0.770s)
[215.461647] Starting dynamic subtest: blt
[216.226664] Dynamic subtest blt: SUCCESS (0.774s)
[216.236468] Starting dynamic subtest: vebox
[216.983934] Dynamic subtest vebox: SUCCESS (0.754s)
[216.986471] Subtest legacy-engines-persistence: SUCCESS (3.895s)
[217.065605] [028/133] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[217.181041] Starting subtest: psr-1p-primscrn-spr-indfb-move
[224.816053] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.637s)
[224.937988] [029/133] (794s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[225.046362] Starting subtest: x-tiled-8bpp-rotate-90
[225.069150] Subtest x-tiled-8bpp-rotate-90: SKIP (0.019s)
[225.180597] [030/133] (794s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[225.265675] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[225.270133] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[225.363856] [031/133] (794s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[225.574908] Starting subtest: cursor-rapid-movement-64x21
[225.621573] Subtest cursor-rapid-movement-64x21: SKIP (0.042s)
[225.838068] [032/133] (793s left) kms_chamelium_hpd (hdmi-hpd-storm)
[226.217214] Subtest hdmi-hpd-storm: SKIP (0.000s)
[227.046092] [033/133] (792s left) api_intel_bb (render-ccs)
[227.104348] Starting subtest: render-ccs
[227.457906] Subtest render-ccs: SUCCESS (0.354s)
[227.565328] [034/133] (792s left) sysfs_heartbeat_interval (mixed)
[227.624035] Starting subtest: mixed
[227.626279] Starting dynamic subtest: vecs0
[232.849031] Dynamic subtest vecs0: SUCCESS (5.223s)
[232.860838] Starting dynamic subtest: ccs0
[238.021953] Dynamic subtest ccs0: SUCCESS (5.171s)
[238.033180] Starting dynamic subtest: vcs0
[243.223777] Dynamic subtest vcs0: SUCCESS (5.199s)
[243.235091] Starting dynamic subtest: bcs0
[248.430287] Dynamic subtest bcs0: SUCCESS (5.205s)
[248.441472] Starting dynamic subtest: rcs0
[253.637966] Dynamic subtest rcs0: SUCCESS (5.206s)
[253.649488] Starting dynamic subtest: vcs1
[258.844960] Dynamic subtest vcs1: SUCCESS (5.205s)
[258.847670] Subtest mixed: SUCCESS (31.220s)
[258.922649] [035/133] (760s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[259.032246] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[259.036311] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[259.133419] [036/133] (760s left) kms_plane_cursor (overlay)
[259.229079] Starting subtest: overlay
[259.233594] Starting dynamic subtest: pipe-A-eDP-1-size-64
[261.777069] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.550s)
[261.837686] Starting dynamic subtest: pipe-A-eDP-1-size-128
[264.356307] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.527s)
[264.419446] Starting dynamic subtest: pipe-A-eDP-1-size-256
[266.938010] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.526s)
[267.284182] Starting dynamic subtest: pipe-B-eDP-1-size-64
[270.504439] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.230s)
[270.566090] Starting dynamic subtest: pipe-B-eDP-1-size-128
[273.039563] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[273.098182] Starting dynamic subtest: pipe-B-eDP-1-size-256
[275.640739] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[275.987440] Starting dynamic subtest: pipe-C-eDP-1-size-64
[278.804505] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.827s)
[278.842023] Starting dynamic subtest: pipe-C-eDP-1-size-128
[280.949460] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.114s)
[280.987410] Starting dynamic subtest: pipe-C-eDP-1-size-256
[283.116500] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.136s)
[283.442668] Starting dynamic subtest: pipe-D-eDP-1-size-64
[286.277216] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.844s)
[286.314629] Starting dynamic subtest: pipe-D-eDP-1-size-128
[288.410303] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.103s)
[288.448138] Starting dynamic subtest: pipe-D-eDP-1-size-256
[290.565489] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.125s)
[290.889430] Subtest overlay: SUCCESS (31.660s)
[291.694481] [037/133] (728s left) kms_chamelium_edid (hdmi-mode-timings)
[292.078316] Subtest hdmi-mode-timings: SKIP (0.000s)
[292.905169] [038/133] (726s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[292.997385] Starting subtest: primary-yf-tiled-reflect-x-270
[293.001306] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[293.082482] [039/133] (726s left) kms_frontbuffer_tracking (psr-2p-rte)
[293.170273] Starting subtest: psr-2p-rte
[293.174709] Subtest psr-2p-rte: SKIP (0.000s)
[293.257240] [040/133] (726s left) gem_media_fill (media-fill)
[293.313683] Subtest media-fill: SKIP (0.000s)
[293.416395] [041/133] (726s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[293.499823] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[293.501949] Starting dynamic subtest: pipe-A-eDP-1
[293.523652] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[293.534474] Starting dynamic subtest: pipe-B-eDP-1
[293.555211] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[293.563222] Starting dynamic subtest: pipe-C-eDP-1
[293.584151] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[293.592226] Starting dynamic subtest: pipe-D-eDP-1
[293.613880] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[293.617930] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[295.773289] [042/133] (724s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[295.858156] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[295.860453] Starting dynamic subtest: pipe-A-eDP-1
[295.883071] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[295.895223] Starting dynamic subtest: pipe-B-eDP-1
[295.915845] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[295.924808] Starting dynamic subtest: pipe-C-eDP-1
[295.945222] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[295.954449] Starting dynamic subtest: pipe-D-eDP-1
[295.975471] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[295.979466] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[298.129729] [043/133] (721s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[298.236915] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[298.239138] Starting dynamic subtest: pipe-A-default-mode
[299.392626] Dynamic subtest pipe-A-default-mode: SKIP (1.154s)
[299.396980] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.156s)
[299.542840] [044/133] (720s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[299.659393] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[299.663589] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[299.748336] [045/133] (720s left) gem_mmap (pf-nonblock)
[299.805333] Subtest pf-nonblock: SKIP (0.000s)
[299.863979] [046/133] (720s left) gem_exec_reloc (basic-write-gtt)
[299.926805] Subtest basic-write-gtt: SKIP (0.000s)
[300.005420] [047/133] (720s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[300.065036] Starting subtest: y-tiled-ccs-to-y-tiled
[300.069970] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[300.248287] [048/133] (719s left) kms_content_protection (dp-mst-type-0)
[300.400895] Starting subtest: dp-mst-type-0
[300.405126] Subtest dp-mst-type-0: SKIP (0.000s)
[300.531218] [049/133] (719s left) gem_wait (write-wait)
[300.599701] Starting subtest: write-wait
[300.601934] Starting dynamic subtest: all-engines
[301.700770] Dynamic subtest all-engines: SUCCESS (1.101s)
[301.717224] Starting dynamic subtest: rcs0
[302.759732] Dynamic subtest rcs0: SUCCESS (1.056s)
[302.777053] Starting dynamic subtest: bcs0
[303.819790] Dynamic subtest bcs0: SUCCESS (1.058s)
[303.837485] Starting dynamic subtest: vcs0
[304.876522] Dynamic subtest vcs0: SUCCESS (1.054s)
[304.892228] Starting dynamic subtest: vcs1
[305.930572] Dynamic subtest vcs1: SUCCESS (1.052s)
[305.946217] Starting dynamic subtest: vecs0
[306.983249] Dynamic subtest vecs0: SUCCESS (1.051s)
[306.999421] Starting dynamic subtest: ccs0
[308.039073] Dynamic subtest ccs0: SUCCESS (1.054s)
[308.041673] Subtest write-wait: SUCCESS (7.441s)
[308.235592] [050/133] (712s left) gem_exec_fence (parallel)
[308.417415] Starting subtest: parallel
[308.419755] Starting dynamic subtest: rcs0
[310.567853] Dynamic subtest rcs0: SUCCESS (2.150s)
[310.578720] Starting dynamic subtest: bcs0
[312.724066] Dynamic subtest bcs0: SUCCESS (2.156s)
[312.734215] Starting dynamic subtest: vcs0
[314.873805] Dynamic subtest vcs0: SUCCESS (2.149s)
[314.883957] Starting dynamic subtest: vcs1
[317.027506] Dynamic subtest vcs1: SUCCESS (2.153s)
[317.038805] Starting dynamic subtest: vecs0
[319.182147] Dynamic subtest vecs0: SUCCESS (2.154s)
[319.193672] Starting dynamic subtest: ccs0
[321.336901] Dynamic subtest ccs0: SUCCESS (2.152s)
[321.339048] Subtest parallel: SUCCESS (12.920s)
[321.973989] [051/133] (698s left) kms_getfb (getfb-handle-closed)
[322.065125] Starting subtest: getfb-handle-closed
[322.067415] Subtest getfb-handle-closed: SUCCESS (0.000s)
[322.171460] [052/133] (698s left) gem_exec_reloc (basic-write-cpu)
[322.231613] Subtest basic-write-cpu: SKIP (0.000s)
[322.302327] [053/133] (698s left) gem_sync (basic-each)
[322.365440] Starting subtest: basic-each
[324.581465] Subtest basic-each: SUCCESS (2.226s)
[324.768368] [054/133] (695s left) kms_sequence (queue-busy)
[324.865912] Starting subtest: queue-busy
[324.868157] Starting dynamic subtest: pipe-A-eDP-1
[326.804828] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[326.813777] Starting dynamic subtest: pipe-B-eDP-1
[329.374647] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.568s)
[329.383883] Starting dynamic subtest: pipe-C-eDP-1
[331.995538] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.616s)
[332.004997] Starting dynamic subtest: pipe-D-eDP-1
[334.541519] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[334.543454] Subtest queue-busy: SUCCESS (9.675s)
[335.418264] [055/133] (685s left) kms_flip (flip-vs-modeset-vs-hang)
[335.518271] Starting subtest: flip-vs-modeset-vs-hang
[335.520590] Starting dynamic subtest: A-eDP1
[387.381428] Dynamic subtest A-eDP1: SUCCESS (51.862s)
[387.391508] Starting dynamic subtest: D-eDP1
[437.364787] Dynamic subtest D-eDP1: SUCCESS (49.977s)
[437.367232] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.847s)
[437.735578] [056/133] (582s left) kms_busy (extended-modeset-hang-newfb)
[437.830283] Starting subtest: extended-modeset-hang-newfb
[437.832560] Starting dynamic subtest: pipe-A
[472.806116] Dynamic subtest pipe-A: SUCCESS (34.972s)
[472.815712] Starting dynamic subtest: pipe-D
[495.793386] Dynamic subtest pipe-D: SUCCESS (22.982s)
[495.795686] Subtest extended-modeset-hang-newfb: SUCCESS (57.958s)
[496.587659] [057/133] (524s left) kms_pm_dc (dc6-psr)
[497.682821] Starting subtest: dc6-psr
[500.574938] Subtest dc6-psr: SUCCESS (2.892s)
[501.426585] [058/133] (519s left) kms_prime (d3hot)
[501.513502] Subtest D3hot: SKIP (0.000s)
[501.608464] [059/133] (519s left) gem_exec_params (sol-reset-not-gen7)
[501.670785] Starting subtest: sol-reset-not-gen7
[501.676354] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[501.799208] [060/133] (518s left) i915_drm_fdinfo (virtual-busy-hang-all)
[501.841720] Starting subtest: virtual-busy-hang-all
[501.846216] Subtest virtual-busy-hang-all: SKIP (0.000s)
[501.907903] [061/133] (518s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[502.015158] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[502.017349] Starting dynamic subtest: pipe-A
[503.164648] Dynamic subtest pipe-A: SUCCESS (1.151s)
[503.173631] Starting dynamic subtest: pipe-B
[505.436851] Dynamic subtest pipe-B: SUCCESS (2.270s)
[505.447287] Starting dynamic subtest: pipe-C
[506.618392] Dynamic subtest pipe-C: SUCCESS (1.180s)
[506.628755] Starting dynamic subtest: pipe-D
[507.852487] Dynamic subtest pipe-D: SUCCESS (1.233s)
[507.854733] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.839s)
[509.040449] [062/133] (511s left) kms_flip (basic-plain-flip)
[509.142183] Starting subtest: basic-plain-flip
[509.144734] Starting dynamic subtest: A-eDP1
[510.837788] Dynamic subtest A-eDP1: SUCCESS (1.695s)
[510.848765] Starting dynamic subtest: B-eDP1
[512.476247] Dynamic subtest B-eDP1: SUCCESS (1.637s)
[512.490043] Starting dynamic subtest: C-eDP1
[514.104737] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[514.114301] Starting dynamic subtest: D-eDP1
[515.756663] Dynamic subtest D-eDP1: SUCCESS (1.651s)
[515.761993] Subtest basic-plain-flip: SUCCESS (6.621s)
[516.931466] [063/133] (503s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[517.021120] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[517.025096] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[517.095063] [064/133] (503s left) prime_vgem (basic-gtt)
[517.182152] Starting subtest: basic-gtt
[517.186730] Subtest basic-gtt: SKIP (0.000s)
[517.283335] [065/133] (503s left) kms_psr (fbc-pr-sprite-plane-move)
[517.378249] Starting subtest: fbc-pr-sprite-plane-move
[517.382102] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[517.450923] [066/133] (503s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[517.581448] Starting subtest: flip-vs-cursor-crc-atomic
[518.275298] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.692s)
[519.158334] [067/133] (501s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[519.258385] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[526.256106] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.000s)
[526.395377] [068/133] (494s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[526.501578] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[533.164993] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.665s)
[533.303247] [069/133] (487s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[533.419275] Starting subtest: 2x-long-cursor-vs-flip-legacy
[533.423590] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[533.564248] [070/133] (487s left) kms_dsc (dsc-with-bpc)
[533.647211] Starting subtest: dsc-with-bpc
[533.678207] Subtest dsc-with-bpc: SKIP (0.001s)
[533.722469] [071/133] (487s left) gem_exec_schedule (smoketest)
[533.902976] Starting subtest: smoketest
[533.905483] Starting dynamic subtest: rcs0
[539.452472] Dynamic subtest rcs0: SUCCESS (5.503s)
[539.467490] Starting dynamic subtest: bcs0
[544.956542] Dynamic subtest bcs0: SUCCESS (5.505s)
[544.967690] Starting dynamic subtest: vcs0
[550.460276] Dynamic subtest vcs0: SUCCESS (5.497s)
[550.471063] Starting dynamic subtest: vcs1
[555.961466] Dynamic subtest vcs1: SUCCESS (5.502s)
[555.971724] Starting dynamic subtest: vecs0
[561.460137] Dynamic subtest vecs0: SUCCESS (5.498s)
[561.470212] Starting dynamic subtest: ccs0
[566.953086] Dynamic subtest ccs0: SUCCESS (5.491s)
[566.955480] Subtest smoketest: SUCCESS (33.003s)
[567.148637] [072/133] (454s left) gem_exec_flush (basic-wb-set-default)
[567.218182] Starting subtest: basic-wb-set-default
[572.697657] Subtest basic-wb-set-default: SUCCESS (5.482s)
[572.897827] [073/133] (448s left) gem_ctx_engines (invalid-engines)
[572.965769] Starting subtest: invalid-engines
[572.975352] Subtest invalid-engines: SUCCESS (0.013s)
[573.217936] [074/133] (448s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[573.279706] Starting subtest: x-tiled-to-vebox-yf-tiled
[573.283966] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[573.466678] [075/133] (447s left) dmabuf_sync_file (import-multiple-read-only)
[573.517179] Starting subtest: import-multiple-read-only
[573.519392] Subtest import-multiple-read-only: SUCCESS (0.003s)
[573.580384] [076/133] (447s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[573.645395] Starting subtest: invalid-single-wait-all-unsubmitted
[573.647642] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[573.741639] [077/133] (447s left) gem_exec_schedule (u-submit-late-slice)
[573.811303] Starting subtest: u-submit-late-slice
[573.813103] Starting dynamic subtest: rcs0
[573.867318] Dynamic subtest rcs0: SUCCESS (0.063s)
[573.878843] Starting dynamic subtest: bcs0
[573.914755] Dynamic subtest bcs0: SUCCESS (0.047s)
[573.933740] Starting dynamic subtest: vcs0
[573.960842] Dynamic subtest vcs0: SUCCESS (0.045s)
[573.970093] Starting dynamic subtest: vcs1
[574.000591] Dynamic subtest vcs1: SUCCESS (0.038s)
[574.009617] Starting dynamic subtest: vecs0
[574.042421] Dynamic subtest vecs0: SUCCESS (0.041s)
[574.052412] Starting dynamic subtest: ccs0
[574.087761] Dynamic subtest ccs0: SUCCESS (0.045s)
[574.090075] Subtest u-submit-late-slice: SUCCESS (0.284s)
[575.020866] [078/133] (446s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[575.126008] Starting subtest: plane-lut1d-pre-ctm3x4
[575.273584] Starting dynamic subtest: pipe-A-plane-0
[575.438807] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[575.448248] Starting dynamic subtest: pipe-A-plane-1
[575.572481] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[575.581569] Starting dynamic subtest: pipe-A-plane-2
[575.738623] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[577.023766] Starting dynamic subtest: pipe-B-plane-0
[577.175988] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[577.187218] Starting dynamic subtest: pipe-B-plane-1
[577.364247] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[577.374460] Starting dynamic subtest: pipe-B-plane-2
[577.531235] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[578.728386] Starting dynamic subtest: pipe-C-plane-0
[578.900465] Dynamic subtest pipe-C-plane-0: SUCCESS (0.177s)
[578.919047] Starting dynamic subtest: pipe-C-plane-1
[579.064644] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[579.074071] Starting dynamic subtest: pipe-C-plane-2
[579.221037] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[580.471321] Starting dynamic subtest: pipe-D-plane-0
[580.608991] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[580.620832] Starting dynamic subtest: pipe-D-plane-1
[580.752608] Dynamic subtest pipe-D-plane-1: SUCCESS (0.142s)
[580.761767] Starting dynamic subtest: pipe-D-plane-2
[580.919483] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[581.217944] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.092s)
[582.019150] [079/133] (439s left) gem_render_tiled_blits (basic)
[582.095093] Subtest basic: SKIP (0.000s)
[582.167687] [080/133] (439s left) api_intel_allocator (fork-simple-stress-signal)
[582.223600] Starting subtest: fork-simple-stress-signal
[587.628745] Subtest fork-simple-stress-signal: SUCCESS (5.406s)
[587.752593] [081/133] (433s left) kms_flip (flip-vs-expired-vblank)
[587.858455] Starting subtest: flip-vs-expired-vblank
[587.860452] Starting dynamic subtest: A-eDP1
[596.522538] Dynamic subtest A-eDP1: SUCCESS (8.665s)
[596.533112] Starting dynamic subtest: B-eDP1
[605.255323] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[605.269756] Starting dynamic subtest: C-eDP1
[613.880558] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[613.890025] Starting dynamic subtest: D-eDP1
[622.515825] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[622.522129] Subtest flip-vs-expired-vblank: SUCCESS (34.666s)
[623.696627] [082/133] (397s left) kms_hdr (bpc-switch-dpms)
[623.788971] Starting subtest: bpc-switch-dpms
[624.864816] Starting dynamic subtest: pipe-A-eDP-1
[629.304821] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.442s)
[629.306973] Subtest bpc-switch-dpms: SUCCESS (5.518s)
[629.418205] [083/133] (392s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[629.516533] Starting subtest: psr-1p-primscrn-cur-indfb-move
[636.840177] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.327s)
[636.968737] [084/133] (384s left) gem_mmap_gtt (basic-read-write)
[637.035772] Subtest basic-read-write: SKIP (0.000s)
[637.092923] [085/133] (384s left) kms_cursor_crc (cursor-size-change)
[637.187680] Starting subtest: cursor-size-change
[637.189964] Starting dynamic subtest: pipe-A-eDP-1
[637.994930] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.807s)
[638.005219] Starting dynamic subtest: pipe-D-eDP-1
[639.483180] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.484s)
[639.485542] Subtest cursor-size-change: SUCCESS (2.295s)
[640.371658] [086/133] (381s left) kms_lease (invalid-create-leases)
[640.473101] Starting subtest: invalid-create-leases
[640.477522] Subtest invalid-create-leases: SUCCESS (0.006s)
[640.600433] [087/133] (381s left) gem_exec_balancer (hang)
[640.857758] Starting subtest: hang
[642.905695] Subtest hang: SUCCESS (2.047s)
[643.023620] [088/133] (378s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[643.121553] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[644.155903] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.034s)
[644.293100] [089/133] (377s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[644.392653] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[644.396189] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[644.500932] [090/133] (377s left) kms_pm_backlight (bad-brightness)
[644.598655] Starting subtest: bad-brightness
[644.648904] Starting dynamic subtest: eDP-1
[644.968929] Dynamic subtest eDP-1: SUCCESS (0.317s)
[644.971575] Subtest bad-brightness: SUCCESS (0.371s)
[645.805240] [091/133] (376s left) i915_drm_fdinfo (busy-hang)
[645.844653] Starting subtest: busy-hang
[645.846948] Starting dynamic subtest: rcs0
[645.873636] Dynamic subtest rcs0: SKIP (0.028s)
[645.882782] Starting dynamic subtest: bcs0
[645.887298] Dynamic subtest bcs0: SKIP (0.001s)
[645.896147] Starting dynamic subtest: vcs0
[645.900348] Dynamic subtest vcs0: SKIP (0.000s)
[645.908787] Starting dynamic subtest: vcs1
[645.912918] Dynamic subtest vcs1: SKIP (0.001s)
[645.921628] Starting dynamic subtest: vecs0
[645.926074] Dynamic subtest vecs0: SKIP (0.001s)
[645.934986] Starting dynamic subtest: ccs0
[645.939361] Dynamic subtest ccs0: SKIP (0.001s)
[645.943742] Subtest busy-hang: SKIP (0.039s)
[645.983345] [092/133] (376s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[646.069375] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[653.231888] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.165s)
[653.384880] [093/133] (368s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[653.475134] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[653.477027] Starting dynamic subtest: pipe-A-eDP-1
[654.218401] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[654.228294] Starting dynamic subtest: pipe-B-eDP-1
[655.995116] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.774s)
[656.006584] Starting dynamic subtest: pipe-C-eDP-1
[657.820319] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.825s)
[657.829824] Starting dynamic subtest: pipe-D-eDP-1
[659.646257] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.824s)
[659.648528] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.165s)
[660.774353] [094/133] (361s left) kms_psr (fbc-psr-sprite-plane-onoff)
[660.862089] Starting subtest: fbc-psr-sprite-plane-onoff
[660.864426] Starting dynamic subtest: eDP-1
[660.868970] Dynamic subtest eDP-1: SKIP (0.000s)
[660.873243] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.002s)
[660.940664] [095/133] (361s left) kms_psr (psr-primary-page-flip)
[661.026176] Starting subtest: psr-primary-page-flip
[661.028528] Starting dynamic subtest: eDP-1
[662.776191] Dynamic subtest eDP-1: SUCCESS (1.751s)
[662.778636] Subtest psr-primary-page-flip: SUCCESS (1.752s)
[663.633929] [096/133] (358s left) gem_exec_schedule (preempt-contexts)
[663.702059] Starting subtest: preempt-contexts
[663.704325] Starting dynamic subtest: rcs0
[663.752323] Dynamic subtest rcs0: SUCCESS (0.059s)
[663.761729] Starting dynamic subtest: bcs0
[663.806654] Dynamic subtest bcs0: SUCCESS (0.054s)
[663.815660] Starting dynamic subtest: vcs0
[663.855441] Dynamic subtest vcs0: SUCCESS (0.047s)
[663.864773] Starting dynamic subtest: vcs1
[663.903663] Dynamic subtest vcs1: SUCCESS (0.048s)
[663.913323] Starting dynamic subtest: vecs0
[663.948773] Dynamic subtest vecs0: SUCCESS (0.044s)
[663.958264] Starting dynamic subtest: ccs0
[664.002066] Dynamic subtest ccs0: SUCCESS (0.053s)
[664.004842] Subtest preempt-contexts: SUCCESS (0.309s)
[665.027979] [097/133] (357s left) kms_cursor_crc (cursor-offscreen-128x128)
[665.244374] Starting subtest: cursor-offscreen-128x128
[665.249327] Starting dynamic subtest: pipe-A-eDP-1
[667.189615] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[667.217133] Starting dynamic subtest: pipe-D-eDP-1
[669.835445] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s)
[669.837804] Subtest cursor-offscreen-128x128: SUCCESS (4.588s)
[670.692471] [098/133] (351s left) gem_blits (basic)
[670.762717] Starting subtest: basic
[672.166687] Subtest basic: SUCCESS (1.405s)
[672.301144] [099/133] (350s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[672.411011] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[673.212995] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.803s)
[673.386599] [100/133] (349s left) kms_psr (pr-sprite-mmap-gtt)
[673.474507] Starting subtest: pr-sprite-mmap-gtt
[673.478692] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[673.563197] [101/133] (348s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[673.666812] Starting subtest: 4-tiled-32bpp-rotate-270
[673.686066] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[673.791114] [102/133] (348s left) gem_ctx_param (invalid-size-set)
[673.840830] Starting subtest: invalid-size-set
[673.843153] Subtest invalid-size-set: SUCCESS (0.001s)
[673.942299] [103/133] (348s left) kms_addfb_basic (bad-pitch-0)
[674.011849] Starting subtest: bad-pitch-0
[674.013837] Subtest bad-pitch-0: SUCCESS (0.000s)
[674.134103] [104/133] (348s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[674.248215] Starting subtest: cursorA-vs-flipA-varying-size
[685.383786] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.134s)
[686.211664] [105/133] (336s left) kms_vblank (query-idle-hang)
[686.305053] Starting subtest: query-idle-hang
[686.307282] Starting dynamic subtest: pipe-A-eDP-1
[693.357297] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.049s)
[693.373771] Starting dynamic subtest: pipe-D-eDP-1
[700.384954] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.028s)
[700.387391] Subtest query-idle-hang: SUCCESS (14.082s)
[701.192876] [106/133] (321s left) gem_softpin (allocator-nopin-reserve)
[701.245055] Starting subtest: allocator-nopin-reserve
[701.341558] Subtest allocator-nopin-reserve: SUCCESS (0.096s)
[701.474205] [107/133] (321s left) kms_flip (absolute-wf_vblank-interruptible)
[701.561076] Starting subtest: absolute-wf_vblank-interruptible
[701.563504] Starting dynamic subtest: A-eDP1
[710.240319] Dynamic subtest A-eDP1: SUCCESS (8.679s)
[710.252062] Starting dynamic subtest: B-eDP1
[718.973239] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[718.987435] Starting dynamic subtest: C-eDP1
[727.695396] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[727.709061] Starting dynamic subtest: D-eDP1
[736.421901] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[736.426667] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.866s)
[737.654804] [108/133] (285s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[737.763792] Starting subtest: fbc-2p-pri-indfb-multidraw
[737.768018] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[737.857500] [109/133] (284s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[737.913199] Starting subtest: single-wait-for-submit-unsubmitted
[738.021771] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[738.101731] [110/133] (284s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[738.226703] Starting subtest: cursorA-vs-flipA-toggle
[749.352930] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.125s)
[750.176620] [111/133] (272s left) gen9_exec_parse (basic-rejected-ctx-param)
[750.240099] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[750.299259] [112/133] (272s left) syncobj_timeline (signal)
[750.351185] Starting subtest: signal
[750.353075] Subtest signal: SUCCESS (0.000s)
[750.445803] [113/133] (272s left) i915_selftest (live)
[752.117382] Starting subtest: live
[752.119550] Starting dynamic subtest: sanitycheck
[756.460159] Dynamic subtest sanitycheck: SUCCESS (4.342s)
[756.469909] Starting dynamic subtest: uncore
[760.749658] Dynamic subtest uncore: SUCCESS (4.287s)
[760.759527] Starting dynamic subtest: workarounds
[763.832375] Dynamic subtest workarounds: SUCCESS (3.081s)
[763.842069] Starting dynamic subtest: gt_engines
[766.873842] Dynamic subtest gt_engines: SUCCESS (3.040s)
[766.883483] Starting dynamic subtest: gt_timelines
[784.677290] Dynamic subtest gt_timelines: SUCCESS (17.802s)
[784.686750] Starting dynamic subtest: gt_contexts
[789.007242] Dynamic subtest gt_contexts: SUCCESS (4.327s)
[789.016742] Starting dynamic subtest: gt_lrc
[793.327854] Dynamic subtest gt_lrc: SUCCESS (4.319s)
[793.337745] Starting dynamic subtest: gt_mocs
[796.262843] Dynamic subtest gt_mocs: SUCCESS (2.932s)
[796.272843] Starting dynamic subtest: gt_pm
[802.983087] Dynamic subtest gt_pm: SUCCESS (6.717s)
[802.991085] Starting dynamic subtest: gt_heartbeat
[807.326618] Dynamic subtest gt_heartbeat: SUCCESS (4.341s)
[807.336320] Starting dynamic subtest: gt_tlb
[816.622257] Dynamic subtest gt_tlb: SUCCESS (9.293s)
[816.631843] Starting dynamic subtest: requests
[830.029986] Dynamic subtest requests: SUCCESS (13.406s)
[830.039177] Starting dynamic subtest: migrate
[837.704290] Dynamic subtest migrate: SUCCESS (7.672s)
[837.714057] Starting dynamic subtest: active
[842.045756] Dynamic subtest active: SUCCESS (4.340s)
[842.055191] Starting dynamic subtest: objects
[846.693450] Dynamic subtest objects: SUCCESS (4.645s)
[846.702035] Starting dynamic subtest: mman
[850.117695] Dynamic subtest mman: SUCCESS (3.422s)
[850.127072] Starting dynamic subtest: dmabuf
[854.494076] Dynamic subtest dmabuf: SUCCESS (4.374s)
[854.503630] Starting dynamic subtest: vma
[858.824929] Dynamic subtest vma: SUCCESS (4.329s)
[858.834380] Starting dynamic subtest: coherency
[864.243069] Dynamic subtest coherency: SUCCESS (5.417s)
[864.252737] Starting dynamic subtest: gtt
[874.091658] Dynamic subtest gtt: SUCCESS (9.847s)
[874.106515] Starting dynamic subtest: gem
[879.637086] Dynamic subtest gem: SUCCESS (5.543s)
[879.646899] Starting dynamic subtest: evict
[883.600970] Dynamic subtest evict: SUCCESS (3.962s)
[883.610336] Starting dynamic subtest: hugepages
[892.364818] Dynamic subtest hugepages: SUCCESS (8.761s)
[892.373750] Starting dynamic subtest: gem_contexts
[920.842634] Dynamic subtest gem_contexts: SUCCESS (28.475s)
[920.856782] Starting dynamic subtest: client
[925.225537] Dynamic subtest client: SUCCESS (4.381s)
[925.235255] Starting dynamic subtest: gem_migrate
[929.524141] Dynamic subtest gem_migrate: SUCCESS (4.297s)
[929.534134] Starting dynamic subtest: reset
[932.257293] Dynamic subtest reset: SUCCESS (2.732s)
[932.267077] Starting dynamic subtest: memory_region
[936.618395] Dynamic subtest memory_region: SUCCESS (4.359s)
[936.628952] Starting dynamic subtest: hangcheck
[949.545346] Dynamic subtest hangcheck: SUCCESS (12.924s)
[949.555425] Starting dynamic subtest: execlists
[953.828949] Dynamic subtest execlists: SUCCESS (4.280s)
[953.838098] Starting dynamic subtest: ring_submission
[958.116826] Dynamic subtest ring_submission: SUCCESS (4.286s)
[958.126675] Starting dynamic subtest: perf
[962.494249] Dynamic subtest perf: SUCCESS (4.376s)
[962.503708] Starting dynamic subtest: slpc
[976.547092] Dynamic subtest slpc: SUCCESS (14.050s)
[976.556656] Starting dynamic subtest: guc
[980.459184] Dynamic subtest guc: SUCCESS (3.909s)
[980.469091] Starting dynamic subtest: guc_multi_lrc
[984.781496] Dynamic subtest guc_multi_lrc: SUCCESS (4.321s)
[984.791170] Starting dynamic subtest: guc_hang
[989.695106] Dynamic subtest guc_hang: SUCCESS (4.912s)
[989.703090] Starting dynamic subtest: late_gt_pm
[992.417449] Dynamic subtest late_gt_pm: SUCCESS (2.719s)
[992.419934] Subtest live: SUCCESS (240.287s)
[992.446231] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[992.447155] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[992.450267] [114/133] ( 30s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[994.043291] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[994.047220] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[994.149150] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[994.150439] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[994.154068] [115/133] ( 28s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[994.269144] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[994.273253] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[994.370604] [116/133] ( 28s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[994.464170] Starting subtest: pr-primary-plane-update-sf-dmg-area
[994.468242] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[994.535443] [117/133] ( 28s left) kms_plane_alpha_blend (coverage-7efc)
[994.625846] Starting subtest: coverage-7efc
[994.924203] Starting dynamic subtest: pipe-A-eDP-1
[995.573548] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s)
[995.604182] Starting dynamic subtest: pipe-D-eDP-1
[996.882849] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s)
[996.885164] Subtest coverage-7efc: SUCCESS (2.259s)
[997.722746] [118/133] ( 25s left) perf_pmu (faulting-read)
[997.766200] Starting subtest: faulting-read
[997.768720] Starting dynamic subtest: wb
[997.771193] Dynamic subtest wb: SUCCESS (0.001s)
[997.781414] Starting dynamic subtest: wc
[997.783704] Dynamic subtest wc: SUCCESS (0.000s)
[997.792049] Starting dynamic subtest: uc
[997.794352] Dynamic subtest uc: SUCCESS (0.000s)
[997.796707] Subtest faulting-read: SUCCESS (0.003s)
[997.875780] [119/133] ( 25s left) prime_mmap (test_correct)
[997.930286] Starting subtest: test_correct
[997.932413] Starting dynamic subtest: test_correct-smem
[997.962309] Dynamic subtest test_correct-smem: SUCCESS (0.034s)
[997.964599] Subtest test_correct: SUCCESS (0.034s)
[998.056414] [120/133] ( 25s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[998.140692] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[998.145154] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[999.255856] [121/133] ( 24s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[999.310249] Starting subtest: etime-multi-wait-all-for-submit-submitted
[999.412890] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[999.500136] [122/133] ( 23s left) gem_exec_reloc (basic-scanout)
[999.558878] Subtest basic-scanout: SKIP (0.000s)
[999.627259] [123/133] ( 23s left) kms_joiner (basic-max-non-joiner)
[999.723590] Starting subtest: basic-max-non-joiner
[999.727924] Subtest basic-max-non-joiner: SKIP (0.000s)
[999.790129] [124/133] ( 23s left) gem_userptr_blits (invalid-null-pointer)
[999.844650] Starting subtest: invalid-null-pointer
[999.846816] Subtest invalid-null-pointer: SUCCESS (0.001s)
[999.967699] [125/133] ( 23s left) gem_mmap_gtt (zero-extend)
[1000.016612] Subtest zero-extend: SKIP (0.000s)
[1000.073407] [126/133] ( 23s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[1000.173168] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[1000.177371] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[1000.263502] [127/133] ( 23s left) perf (gen12-group-concurrent-oa-buffer-read)
[1000.394544] Starting subtest: gen12-group-concurrent-oa-buffer-read
[1010.421819] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.026s)
[1010.478942] [128/133] ( 13s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[1010.539056] Starting subtest: invalid-single-wait-all-unsubmitted
[1010.541115] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[1010.619421] [129/133] ( 12s left) kms_cursor_crc (cursor-sliding-512x512)
[1010.907976] Starting subtest: cursor-sliding-512x512
[1010.912427] Subtest cursor-sliding-512x512: SKIP (0.001s)
[1011.065981] [130/133] ( 12s left) kms_psr (psr2-primary-render)
[1011.170995] Starting subtest: psr2-primary-render
[1011.173268] Starting dynamic subtest: eDP-1
[1012.856189] Dynamic subtest eDP-1: SUCCESS (1.683s)
[1012.858438] Subtest psr2-primary-render: SUCCESS (1.684s)
[1013.731798] [131/133] (  9s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[1013.790684] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[1013.893082] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[1013.985833] [132/133] (  9s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[1014.088894] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[1014.093302] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[1014.187864] [133/133] (  9s left) kms_addfb_basic (bad-pitch-256)
[1014.246326] Starting subtest: bad-pitch-256
[1014.248270] Subtest bad-pitch-256: SUCCESS (0.000s)
[1014.385869] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: i915_pm_rc6_residency
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_async_flips
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: prime_vgem
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: gem_exec_capture
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: gem_ppgtt
results: parsing output: 23/ for test: kms_prop_blob
results: parsing output: 24/ for test: syncobj_basic
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: sysfs_heartbeat_interval
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_plane_cursor
results: parsing output: 36/ for test: kms_chamelium_edid
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_media_fill
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: gem_wait
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_getfb
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: gem_sync
results: parsing output: 53/ for test: kms_sequence
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_busy
results: parsing output: 56/ for test: kms_pm_dc
results: parsing output: 57/ for test: kms_prime
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: prime_vgem
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_dsc
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: gem_ctx_engines
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: dmabuf_sync_file
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_color_pipeline
results: parsing output: 78/ for test: gem_render_tiled_blits
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_hdr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: kms_lease
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_pm_backlight
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_blits
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: gem_softpin
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: i915_selftest
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_plane_alpha_blend
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: prime_mmap
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_joiner
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_addfb_basic
Done.