[57.815828] Initializing watchdogs [57.815874] /dev/watchdog0 [57.829512] [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.833694] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.835916] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.839529] [001/133] (960s left) gem_spin_batch (legacy-resubmit-new) [57.916908] Starting subtest: legacy-resubmit-new [57.919140] Starting dynamic subtest: default [57.930212] Dynamic subtest default: SUCCESS (0.013s) [57.941264] Starting dynamic subtest: render [57.943850] Dynamic subtest render: SUCCESS (0.005s) [57.956860] Starting dynamic subtest: bsd [57.959800] Dynamic subtest bsd: SUCCESS (0.007s) [57.970284] Starting dynamic subtest: bsd1 [57.972095] Dynamic subtest bsd1: SUCCESS (0.003s) [57.979396] Starting dynamic subtest: bsd2 [57.981225] Dynamic subtest bsd2: SUCCESS (0.006s) [57.988064] Starting dynamic subtest: blt [57.990031] Dynamic subtest blt: SUCCESS (0.006s) [57.996075] Starting dynamic subtest: vebox [57.998094] Dynamic subtest vebox: SUCCESS (0.006s) [57.999931] Subtest legacy-resubmit-new: SUCCESS (0.050s) [59.962809] [002/133] (958s left) kms_cursor_crc (cursor-offscreen-512x512) [60.250367] Starting subtest: cursor-offscreen-512x512 [60.254717] Subtest cursor-offscreen-512x512: SKIP (0.001s) [60.408813] [003/133] (958s left) kms_invalid_mode (bad-htotal) [60.497795] Starting subtest: bad-htotal [60.500099] Starting dynamic subtest: pipe-A-eDP-1 [60.789972] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s) [60.798211] Starting dynamic subtest: pipe-B-eDP-1 [60.800653] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [60.807546] Starting dynamic subtest: pipe-C-eDP-1 [60.809804] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [60.816363] Starting dynamic subtest: pipe-D-eDP-1 [60.818330] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [60.820665] Subtest bad-htotal: SUCCESS (0.303s) [61.650100] [004/133] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [61.749781] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [69.151854] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (7.427s) [69.285506] [005/133] (949s left) gem_exec_fence (submit3) [69.450120] Starting subtest: submit3 [69.454938] Subtest submit3: SKIP (0.000s) [70.925900] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [70.930439] [006/133] (947s left) kms_cursor_crc (cursor-random-512x512) [71.207880] Starting subtest: cursor-random-512x512 [71.212307] Subtest cursor-random-512x512: SKIP (0.001s) [71.359108] [007/133] (947s left) gem_exec_params (larger-than-life-batch) [71.412762] Starting subtest: larger-than-life-batch [73.670552] Subtest larger-than-life-batch: SUCCESS (2.258s) [74.953653] [008/133] (943s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [75.095583] Starting subtest: yf-tiled-64bpp-rotate-90 [75.099872] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.001s) [75.189148] [009/133] (943s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [75.293770] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [75.295951] Starting dynamic subtest: pipe-A-eDP-1 [75.304738] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [75.314206] Starting dynamic subtest: pipe-B-eDP-1 [75.322839] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [75.331183] Starting dynamic subtest: pipe-C-eDP-1 [75.339209] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [75.346244] Starting dynamic subtest: pipe-D-eDP-1 [75.354191] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [75.358638] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [77.597324] [010/133] (941s left) kms_cursor_legacy (forked-move) [77.711291] Starting subtest: forked-move [77.713620] Starting dynamic subtest: pipe-A [83.199428] Dynamic subtest pipe-A: SUCCESS (5.486s) [83.209730] Starting dynamic subtest: pipe-B [88.679575] Dynamic subtest pipe-B: SUCCESS (5.478s) [88.689608] Starting dynamic subtest: pipe-C [94.159765] Dynamic subtest pipe-C: SUCCESS (5.479s) [94.172969] Starting dynamic subtest: pipe-D [99.640707] Dynamic subtest pipe-D: SUCCESS (5.480s) [99.651383] Starting dynamic subtest: all-pipes [105.138046] Dynamic subtest all-pipes: SUCCESS (5.495s) [105.140593] Subtest forked-move: SUCCESS (27.422s) [105.285725] [011/133] (913s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs) [105.407812] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs [105.410525] Starting dynamic subtest: pipe-A-eDP-1 [105.420099] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [105.430307] Starting dynamic subtest: pipe-B-eDP-1 [105.439316] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [105.447089] Starting dynamic subtest: pipe-C-eDP-1 [105.455428] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [105.462741] Starting dynamic subtest: pipe-D-eDP-1 [105.471193] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [105.475267] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.003s) [107.651804] [012/133] (911s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [107.758429] Starting subtest: fbc-modesetfrombusy [111.508935] Subtest fbc-modesetfrombusy: SUCCESS (3.755s) [112.695166] [013/133] (906s left) gem_softpin (32b-excludes-last-page) [112.762663] Starting subtest: 32b-excludes-last-page [112.765173] Subtest 32b-excludes-last-page: SUCCESS (0.004s) [112.900111] [014/133] (905s left) gem_mmap_gtt (fault-concurrent-x) [112.954403] Subtest fault-concurrent-X: SKIP (0.000s) [113.026900] [015/133] (905s left) syncobj_timeline (wait-for-submit-complex) [113.084534] Starting subtest: wait-for-submit-complex [113.147031] Subtest wait-for-submit-complex: SUCCESS (0.062s) [113.237473] [016/133] (905s left) kms_vrr (lobf) [113.338394] Starting subtest: lobf [113.343073] Subtest lobf: SKIP (0.000s) [113.412687] [017/133] (905s left) gem_ctx_persistence (file) [113.483058] Starting subtest: file [113.591042] Subtest file: SUCCESS (0.108s) [113.719999] [018/133] (905s left) kms_cursor_edge_walk (64x64-top-edge) [113.819747] Starting subtest: 64x64-top-edge [113.821695] Starting dynamic subtest: pipe-A-eDP-1 [117.248062] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.424s) [117.257565] Starting dynamic subtest: pipe-D-eDP-1 [120.366050] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s) [120.368431] Subtest 64x64-top-edge: SUCCESS (6.546s) [121.187373] [019/133] (897s left) gem_lmem_swapping (heavy-verify-random) [121.234838] Subtest heavy-verify-random: SKIP (0.000s) [121.282769] [020/133] (897s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [121.380646] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [121.382921] Starting dynamic subtest: pipe-A-default-mode [122.545515] Dynamic subtest pipe-A-default-mode: SKIP (1.161s) [122.549997] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.162s) [122.675328] [021/133] (896s left) syncobj_wait (invalid-signal-bad-pad) [122.735520] Starting subtest: invalid-signal-bad-pad [122.737520] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [122.849724] [022/133] (896s left) syncobj_eventfd (invalid-bad-flags) [122.910099] Starting subtest: invalid-bad-flags [122.912383] Subtest invalid-bad-flags: SUCCESS (0.000s) [123.002735] [023/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [123.102301] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [123.106808] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [123.206963] [024/133] (896s left) gem_exec_schedule (noreorder-corked) [123.393483] Starting subtest: noreorder-corked [123.395640] Starting dynamic subtest: rcs0 [124.521329] Dynamic subtest rcs0: SUCCESS (1.131s) [124.532351] Starting dynamic subtest: vcs0 [125.902737] Dynamic subtest vcs0: SUCCESS (1.378s) [125.914591] Starting dynamic subtest: vcs1 [127.893646] Dynamic subtest vcs1: SUCCESS (1.990s) [127.906922] Starting dynamic subtest: vecs0 [129.941499] Dynamic subtest vecs0: SUCCESS (2.046s) [129.952570] Starting dynamic subtest: ccs0 [131.093048] Dynamic subtest ccs0: SUCCESS (1.152s) [131.096056] Subtest noreorder-corked: SUCCESS (7.703s) [131.278507] [025/133] (888s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [131.387573] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [132.409032] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.022s) [132.516404] [026/133] (886s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [132.632427] Starting subtest: fbcpsr-rgb565-draw-blt [139.628236] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.997s) [139.774841] [027/133] (879s left) kms_atomic (crtc-invalid-params-fence) [139.877962] Starting subtest: crtc-invalid-params-fence [139.880406] Starting dynamic subtest: pipe-A-eDP-1 [140.281134] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.403s) [140.283495] Subtest crtc-invalid-params-fence: SUCCESS (0.405s) [141.075431] [028/133] (878s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [141.174354] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [145.665936] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.495s) [146.869590] [029/133] (872s left) drm_read (short-buffer-nonblock) [147.005051] Starting subtest: short-buffer-nonblock [147.007543] Subtest short-buffer-nonblock: SUCCESS (0.000s) [147.143413] [030/133] (872s left) syncobj_wait (invalid-wait-illegal-handle) [147.197137] Starting subtest: invalid-wait-illegal-handle [147.199393] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [147.298260] [031/133] (872s left) gem_pxp (protected-encrypted-src-copy-not-readible) [147.427307] Starting subtest: protected-encrypted-src-copy-not-readible [147.540614] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.114s) [147.668458] [032/133] (871s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [147.729944] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [147.789056] [033/133] (871s left) gem_exec_reloc (basic-wc-cpu-noreloc) [147.855088] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [147.927477] [034/133] (871s left) dmabuf_sync_file (export-basic) [147.969605] Starting subtest: export-basic [147.971836] Subtest export-basic: SUCCESS (0.001s) [148.037424] [035/133] (871s left) gem_mmap (big-bo) [148.098059] Subtest big-bo: SKIP (0.000s) [148.158599] [036/133] (871s left) i915_drm_fdinfo (memory-info-resident) [148.196088] Starting subtest: memory-info-resident [148.198404] Starting dynamic subtest: smem0 [150.621374] Dynamic subtest smem0: SUCCESS (2.428s) [150.623503] Subtest memory-info-resident: SUCCESS (2.428s) [150.693694] [037/133] (869s left) kms_plane_cursor (overlay) [150.781039] Starting subtest: overlay [150.784659] Starting dynamic subtest: pipe-A-eDP-1-size-64 [153.276838] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.493s) [153.335154] Starting dynamic subtest: pipe-A-eDP-1-size-128 [155.724087] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.397s) [155.780811] Starting dynamic subtest: pipe-A-eDP-1-size-256 [158.235096] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.460s) [158.586103] Starting dynamic subtest: pipe-B-eDP-1-size-64 [161.701531] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.124s) [161.761644] Starting dynamic subtest: pipe-B-eDP-1-size-128 [164.203727] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.449s) [164.262050] Starting dynamic subtest: pipe-B-eDP-1-size-256 [166.781090] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.526s) [167.126760] Starting dynamic subtest: pipe-C-eDP-1-size-64 [169.905915] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.787s) [169.943457] Starting dynamic subtest: pipe-C-eDP-1-size-128 [172.027538] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.091s) [172.066325] Starting dynamic subtest: pipe-C-eDP-1-size-256 [174.207162] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s) [174.536226] Starting dynamic subtest: pipe-D-eDP-1-size-64 [177.482117] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.957s) [177.519048] Starting dynamic subtest: pipe-D-eDP-1-size-128 [179.726027] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.213s) [179.765469] Starting dynamic subtest: pipe-D-eDP-1-size-256 [181.915056] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s) [182.248484] Subtest overlay: SUCCESS (31.463s) [183.088780] [038/133] (836s left) kms_chamelium_hpd (dp-hpd) [183.490218] Subtest dp-hpd: SKIP (0.000s) [184.296302] [039/133] (835s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [184.355083] Starting subtest: invalid-multi-wait-all-unsubmitted [184.357294] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [184.468988] [040/133] (835s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [184.565951] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [184.577404] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s) [184.706106] [041/133] (835s left) kms_lease (cursor-implicit-plane) [184.798241] Starting subtest: cursor-implicit-plane [184.800178] Starting dynamic subtest: pipe-A-eDP-1 [185.258815] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s) [185.267676] Starting dynamic subtest: pipe-B-eDP-1 [186.337051] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.074s) [186.345530] Starting dynamic subtest: pipe-C-eDP-1 [187.463383] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s) [187.472059] Starting dynamic subtest: pipe-D-eDP-1 [188.587979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s) [188.590343] Subtest cursor-implicit-plane: SUCCESS (3.791s) [189.444442] [042/133] (830s left) syncobj_timeline (multi-wait-available-submitted) [189.499079] Starting subtest: multi-wait-available-submitted [189.501329] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [189.589114] [043/133] (830s left) gem_create (hog-create) [189.649745] Starting subtest: hog-create [189.652140] Starting dynamic subtest: smem0 [223.905196] Dynamic subtest smem0: SUCCESS (34.252s) [223.907781] Subtest hog-create: SUCCESS (34.254s) [224.091270] [044/133] (795s left) dumb_buffer (map-uaf) [224.141805] Starting subtest: map-uaf [224.144189] Subtest map-uaf: SUCCESS (0.005s) [224.253778] [045/133] (795s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [224.369764] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [224.374254] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [224.483350] [046/133] (795s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [224.581335] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [224.585429] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [224.684764] [047/133] (795s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [224.795782] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [231.808779] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.015s) [231.942479] [048/133] (788s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [232.038861] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [232.041166] Starting dynamic subtest: pipe-A-eDP-1 [243.335501] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.299s) [243.343720] Starting dynamic subtest: pipe-B-eDP-1 [255.382508] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.046s) [255.384824] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.348s) [256.235845] [049/133] (764s left) gem_ctx_isolation (preservation) [256.305117] Starting subtest: preservation [256.307483] Starting dynamic subtest: rcs0 [256.439730] Dynamic subtest rcs0: SUCCESS (0.134s) [256.450817] Starting dynamic subtest: bcs0 [256.604052] Dynamic subtest bcs0: SUCCESS (0.163s) [256.615057] Starting dynamic subtest: vcs0 [256.761544] Dynamic subtest vcs0: SUCCESS (0.157s) [256.773073] Starting dynamic subtest: vcs1 [257.978348] Dynamic subtest vcs1: SUCCESS (1.216s) [257.990077] Starting dynamic subtest: vecs0 [260.035624] Dynamic subtest vecs0: SUCCESS (2.055s) [260.046963] Starting dynamic subtest: ccs0 [262.037873] Dynamic subtest ccs0: SUCCESS (2.002s) [262.040754] Subtest preservation: SUCCESS (5.733s) [262.276916] [050/133] (758s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [262.376378] Starting subtest: plane-downscale-factor-0-75-with-rotation [262.378543] Starting dynamic subtest: pipe-A [262.606510] Dynamic subtest pipe-A: SUCCESS (0.230s) [262.615491] Starting dynamic subtest: pipe-B [263.892093] Dynamic subtest pipe-B: SUCCESS (1.284s) [263.901065] Starting dynamic subtest: pipe-C [265.239075] Dynamic subtest pipe-C: SUCCESS (1.346s) [265.250257] Starting dynamic subtest: pipe-D [266.548217] Dynamic subtest pipe-D: SUCCESS (1.307s) [266.550420] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.172s) [267.726418] [051/133] (752s left) kms_color (legacy-gamma-reset) [267.828279] Starting subtest: legacy-gamma-reset [267.830138] Starting dynamic subtest: pipe-A-eDP-1 [268.207295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.381s) [268.215303] Starting dynamic subtest: pipe-B-eDP-1 [268.220180] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s) [268.228071] Starting dynamic subtest: pipe-C-eDP-1 [268.234159] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s) [268.243648] Starting dynamic subtest: pipe-D-eDP-1 [268.245875] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [268.248169] Subtest legacy-gamma-reset: SUCCESS (0.420s) [269.057488] [052/133] (751s left) kms_pm_rpm (fences) [270.988836] Starting subtest: fences [270.993993] Subtest fences: SKIP (0.000s) [271.389546] [053/133] (749s left) gem_mmap_gtt (basic-small-copy) [271.436593] Subtest basic-small-copy: SKIP (0.000s) [271.499275] [054/133] (748s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [271.605482] Starting subtest: flip-vs-cursor-crc-legacy [272.288936] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.681s) [273.088962] [055/133] (747s left) i915_pm_rpm (system-suspend-devices) [275.017083] Starting subtest: system-suspend-devices [282.827039] Subtest system-suspend-devices: SUCCESS (7.808s) [283.213607] [056/133] (737s left) gen9_exec_parse (bb-start-cmd) [283.308732] Subtest bb-start-cmd: SKIP (0.000s) [283.388097] [057/133] (737s left) syncobj_timeline (wait-all-interrupted) [283.445538] Starting subtest: wait-all-interrupted [283.545056] Subtest wait-all-interrupted: SUCCESS (0.101s) [283.626238] [058/133] (736s left) gem_wait (busy) [283.695346] Starting subtest: busy [283.697852] Starting dynamic subtest: all-engines [284.886895] Dynamic subtest all-engines: SUCCESS (1.188s) [284.899496] Starting dynamic subtest: rcs0 [285.426469] Dynamic subtest rcs0: SUCCESS (0.539s) [285.438080] Starting dynamic subtest: bcs0 [285.966220] Dynamic subtest bcs0: SUCCESS (0.539s) [285.977950] Starting dynamic subtest: vcs0 [287.894575] Dynamic subtest vcs0: SUCCESS (1.926s) [287.905976] Starting dynamic subtest: vcs1 [289.942890] Dynamic subtest vcs1: SUCCESS (2.045s) [289.955062] Starting dynamic subtest: vecs0 [291.926336] Dynamic subtest vecs0: SUCCESS (1.981s) [291.938520] Starting dynamic subtest: ccs0 [292.468466] Dynamic subtest ccs0: SUCCESS (0.541s) [292.471060] Subtest busy: SUCCESS (8.772s) [292.677834] [059/133] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [292.775313] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [292.779649] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [292.869891] [060/133] (727s left) kms_psr (psr2-dpms) [292.958303] Starting subtest: psr2-dpms [292.960603] Starting dynamic subtest: eDP-1 [295.838775] Dynamic subtest eDP-1: SUCCESS (2.880s) [295.841059] Subtest psr2-dpms: SUCCESS (2.881s) [296.711210] [061/133] (724s left) kms_plane (pixel-format-yf-tiled-modifier) [296.810108] Starting subtest: pixel-format-yf-tiled-modifier [296.814426] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s) [296.880898] [062/133] (723s left) gem_exec_balancer (bonded-semaphore) [296.943068] Starting subtest: bonded-semaphore [296.947323] Subtest bonded-semaphore: SKIP (0.000s) [297.256354] [063/133] (723s left) kms_psr (fbc-psr-primary-mmap-gtt) [297.350373] Starting subtest: fbc-psr-primary-mmap-gtt [297.352332] Starting dynamic subtest: eDP-1 [297.356508] Dynamic subtest eDP-1: SKIP (0.000s) [297.360658] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s) [297.438408] [064/133] (723s left) kms_big_fb (y-tiled-16bpp-rotate-0) [297.536026] Starting subtest: y-tiled-16bpp-rotate-0 [297.540422] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [297.653842] [065/133] (723s left) kms_big_fb (4-tiled-addfb) [297.761028] Starting subtest: 4-tiled-addfb [297.763308] Subtest 4-tiled-addfb: SUCCESS (0.000s) [297.875176] [066/133] (723s left) kms_cdclk (mode-transition-all-outputs) [297.963573] Starting subtest: mode-transition-all-outputs [298.260863] Subtest mode-transition-all-outputs: SKIP (0.294s) [299.056131] [067/133] (721s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [299.151536] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [306.223328] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.075s) [307.371068] [068/133] (713s left) gem_busy (close-race) [307.432766] Starting subtest: close-race [330.903535] Subtest close-race: SUCCESS (23.468s) [331.324848] [069/133] (689s left) perf_pmu (rc6-suspend) [331.400039] Starting subtest: rc6-suspend [354.390282] Subtest rc6-suspend: SUCCESS (7.592s) [355.290788] [070/133] (665s left) gem_exec_balancer (waits) [355.368007] Starting subtest: waits [361.799884] Subtest waits: SUCCESS (6.511s) [362.116593] [071/133] (659s left) kms_psr (pr-sprite-render) [362.219268] Starting subtest: pr-sprite-render [362.223678] Subtest pr-sprite-render: SKIP (0.000s) [362.295982] [072/133] (658s left) vgem_basic (dmabuf-mmap) [362.344039] Starting subtest: dmabuf-mmap [362.367711] Subtest dmabuf-mmap: SUCCESS (0.026s) [362.428788] [073/133] (658s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [362.524776] Starting subtest: fbcpsr-farfromfence-mmap-gtt [362.529103] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [362.649621] [074/133] (658s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [362.745444] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [369.964962] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.255s) [370.099205] [075/133] (651s left) gem_flink_basic (flink-lifetime) [370.156443] Starting subtest: flink-lifetime [370.158785] Subtest flink-lifetime: SUCCESS (0.002s) [370.259118] [076/133] (651s left) gem_exec_schedule (u-independent) [370.333525] Starting subtest: u-independent [370.335821] Starting dynamic subtest: rcs0 [371.426509] Dynamic subtest rcs0: SUCCESS (1.105s) [371.438407] Starting dynamic subtest: vcs0 [373.420042] Dynamic subtest vcs0: SUCCESS (1.996s) [373.433857] Starting dynamic subtest: vcs1 [375.400653] Dynamic subtest vcs1: SUCCESS (1.982s) [375.413042] Starting dynamic subtest: vecs0 [377.463069] Dynamic subtest vecs0: SUCCESS (2.063s) [377.475784] Starting dynamic subtest: ccs0 [379.425604] Dynamic subtest ccs0: SUCCESS (1.963s) [379.428834] Subtest u-independent: SUCCESS (9.120s) [379.727076] [077/133] (641s left) perf (stress-open-close) [379.870795] Starting subtest: stress-open-close [379.872941] Starting dynamic subtest: 0-rcs0 [382.031237] Dynamic subtest 0-rcs0: SUCCESS (2.165s) [382.044701] Starting dynamic subtest: 1-vcs1 [384.203479] Dynamic subtest 1-vcs1: SUCCESS (2.170s) [384.205537] Subtest stress-open-close: SUCCESS (4.339s) [384.254879] [078/133] (637s left) gem_fence_thrash (bo-write-verify-threaded-y) [384.290003] Starting subtest: bo-write-verify-threaded-y [384.302260] Subtest bo-write-verify-threaded-y: SKIP (0.013s) [384.362718] [079/133] (637s left) syncobj_wait (wait-for-submit-delayed-submit) [384.418773] Starting subtest: wait-for-submit-delayed-submit [384.521462] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [384.613589] [080/133] (636s left) kms_rmfb (rmfb-ioctl) [384.719176] Starting subtest: rmfb-ioctl [384.721460] Starting dynamic subtest: pipe-A-eDP-1 [384.823323] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [384.834533] Starting dynamic subtest: pipe-B-eDP-1 [385.974503] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s) [385.985706] Starting dynamic subtest: pipe-C-eDP-1 [387.104084] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s) [387.115283] Starting dynamic subtest: pipe-D-eDP-1 [388.239295] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [388.241570] Subtest rmfb-ioctl: SUCCESS (3.520s) [389.362982] [081/133] (632s left) gem_ctx_shared (q-out-order) [389.435625] Starting subtest: Q-out-order [389.437989] Starting dynamic subtest: rcs0 [389.538806] Dynamic subtest rcs0: SUCCESS (0.102s) [389.555982] Starting dynamic subtest: vcs0 [389.616182] Dynamic subtest vcs0: SUCCESS (0.077s) [389.633772] Starting dynamic subtest: vcs1 [389.695504] Dynamic subtest vcs1: SUCCESS (0.078s) [389.712423] Starting dynamic subtest: vecs0 [389.766047] Dynamic subtest vecs0: SUCCESS (0.070s) [389.783152] Starting dynamic subtest: ccs0 [389.842302] Dynamic subtest ccs0: SUCCESS (0.076s) [389.845000] Subtest Q-out-order: SUCCESS (0.407s) [391.490709] [082/133] (630s left) gem_gtt_cpu_tlb [391.620254] [083/133] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [391.706740] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [398.396475] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.693s) [398.531997] [084/133] (623s left) gem_ppgtt (shrink-vs-evict-pinned) [398.589747] Starting subtest: shrink-vs-evict-pinned [404.406394] Subtest shrink-vs-evict-pinned: SUCCESS (5.815s) [404.483830] [085/133] (617s left) api_intel_bb (intel-bb-blit-none) [404.539947] Starting subtest: intel-bb-blit-none [408.283206] Subtest intel-bb-blit-none: SUCCESS (3.744s) [408.415505] [086/133] (613s left) kms_addfb_basic (bad-pitch-0) [408.468333] Starting subtest: bad-pitch-0 [408.470687] Subtest bad-pitch-0: SUCCESS (0.000s) [408.604921] [087/133] (613s left) kms_big_fb (x-tiled-64bpp-rotate-270) [408.708689] Starting subtest: x-tiled-64bpp-rotate-270 [408.728373] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [408.832149] [088/133] (613s left) gem_exec_reloc (basic-write-gtt-active) [408.897095] Subtest basic-write-gtt-active: SKIP (0.000s) [408.978008] [089/133] (612s left) syncobj_timeline (invalid-transfer-bad-pad) [409.031194] Starting subtest: invalid-transfer-bad-pad [409.033381] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [409.121112] [090/133] (612s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [409.215819] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [409.220290] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [409.308782] [091/133] (612s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [409.397539] Starting subtest: bad-pixel-format-y-tiled-ccs [409.399450] Starting dynamic subtest: pipe-A-eDP-1 [409.419185] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [409.433433] Starting dynamic subtest: pipe-B-eDP-1 [409.451647] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [409.460143] Starting dynamic subtest: pipe-C-eDP-1 [409.478109] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [409.487000] Starting dynamic subtest: pipe-D-eDP-1 [409.505765] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [409.509505] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [411.558956] [092/133] (610s left) kms_rotation_crc (sprite-rotation-90) [411.656885] Starting subtest: sprite-rotation-90 [411.661325] Subtest sprite-rotation-90: SKIP (0.001s) [411.734624] [093/133] (610s left) kms_hdr (static-swap) [411.827934] Starting subtest: static-swap [411.834361] Subtest static-swap: SKIP (0.000s) [411.903322] [094/133] (610s left) kms_async_flips (async-flip-with-page-flip-events-linear) [412.015838] Starting subtest: async-flip-with-page-flip-events-linear [412.403610] Starting dynamic subtest: pipe-A-eDP-1 [415.139187] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.735s) [415.504753] Starting dynamic subtest: pipe-B-eDP-1 [418.259689] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s) [418.620818] Starting dynamic subtest: pipe-C-eDP-1 [421.385154] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s) [421.756992] Starting dynamic subtest: pipe-D-eDP-1 [424.510719] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s) [424.513311] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.499s) [425.709912] [095/133] (596s left) gem_exec_schedule (u-submit-late-slice) [425.783746] Starting subtest: u-submit-late-slice [425.785741] Starting dynamic subtest: rcs0 [425.809842] Dynamic subtest rcs0: SUCCESS (0.033s) [425.821722] Starting dynamic subtest: bcs0 [425.837425] Dynamic subtest bcs0: SUCCESS (0.027s) [425.848974] Starting dynamic subtest: vcs0 [425.867871] Dynamic subtest vcs0: SUCCESS (0.030s) [425.877660] Starting dynamic subtest: vcs1 [425.895006] Dynamic subtest vcs1: SUCCESS (0.027s) [425.904919] Starting dynamic subtest: vecs0 [425.920952] Dynamic subtest vecs0: SUCCESS (0.025s) [425.932647] Starting dynamic subtest: ccs0 [425.950238] Dynamic subtest ccs0: SUCCESS (0.028s) [425.952605] Subtest u-submit-late-slice: SUCCESS (0.175s) [427.510431] [096/133] (594s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [427.605313] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [427.609445] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [427.702658] [097/133] (594s left) gem_softpin (noreloc-interruptible) [427.758750] Starting subtest: noreloc-interruptible [433.170236] Subtest noreloc-interruptible: SUCCESS (5.412s) [433.282135] [098/133] (589s left) kms_vrr (flip-basic) [433.379254] Starting subtest: flip-basic [433.385794] Subtest flip-basic: SKIP (0.000s) [433.458391] [099/133] (588s left) gem_exec_reloc (basic-cpu-gtt-active) [433.522187] Subtest basic-cpu-gtt-active: SKIP (0.000s) [433.598595] [100/133] (588s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [433.663969] Starting subtest: invalid-bsd1-flag-on-vebox [433.666355] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [433.784629] [101/133] (588s left) kms_flip (flip-vs-dpms-on-nop) [433.876877] Starting subtest: flip-vs-dpms-on-nop [433.879040] Starting dynamic subtest: A-eDP1 [435.794487] Dynamic subtest A-eDP1: SUCCESS (1.919s) [435.807521] Starting dynamic subtest: B-eDP1 [437.633823] Dynamic subtest B-eDP1: SUCCESS (1.837s) [437.645603] Starting dynamic subtest: C-eDP1 [439.464242] Dynamic subtest C-eDP1: SUCCESS (1.830s) [439.476602] Starting dynamic subtest: D-eDP1 [441.299130] Dynamic subtest D-eDP1: SUCCESS (1.831s) [441.304029] Subtest flip-vs-dpms-on-nop: SUCCESS (7.431s) [442.467021] [102/133] (580s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [442.567394] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [442.571466] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [442.656664] [103/133] (579s left) i915_query (query-topology-unsupported) [442.712524] Starting subtest: query-topology-unsupported [442.716552] Subtest query-topology-unsupported: SKIP (0.000s) [442.807697] [104/133] (579s left) api_intel_allocator (fork-simple-once) [442.861531] Starting subtest: fork-simple-once [442.871261] Subtest fork-simple-once: SUCCESS (0.013s) [443.000581] [105/133] (579s left) i915_module_load (reload-no-display) [443.035710] Starting subtest: reload-no-display [448.187186] Subtest reload-no-display: SUCCESS (5.157s) [448.217434] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [448.218351] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [448.221643] [106/133] (574s left) kms_properties (colorop-properties-legacy) [449.788770] Starting subtest: colorop-properties-legacy [449.790730] Starting dynamic subtest: pipe-A-eDP-1 [450.146552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s) [450.159634] Starting dynamic subtest: pipe-B-eDP-1 [451.187493] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.039s) [451.196417] Starting dynamic subtest: pipe-C-eDP-1 [452.232651] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.044s) [452.242114] Starting dynamic subtest: pipe-D-eDP-1 [453.268649] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.033s) [453.270922] Subtest colorop-properties-legacy: SUCCESS (3.479s) [454.108496] [FACT kms_properties (colorop-properties-legacy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [454.109689] [FACT kms_properties (colorop-properties-legacy)] new: kernel.kmod_is_loaded.i915: true [454.114396] [107/133] (568s left) kms_plane_scaling (planes-upscale-20x20) [454.219532] Starting subtest: planes-upscale-20x20 [454.221949] Starting dynamic subtest: pipe-A [454.279349] Dynamic subtest pipe-A: SUCCESS (0.062s) [454.290273] Starting dynamic subtest: pipe-B [455.394281] Dynamic subtest pipe-B: SUCCESS (1.114s) [455.403614] Starting dynamic subtest: pipe-C [456.498351] Dynamic subtest pipe-C: SUCCESS (1.102s) [456.506862] Starting dynamic subtest: pipe-D [457.635536] Dynamic subtest pipe-D: SUCCESS (1.136s) [457.637842] Subtest planes-upscale-20x20: SUCCESS (3.418s) [458.792343] [108/133] (563s left) i915_suspend (sysfs-reader) [458.852179] Starting subtest: sysfs-reader [477.219989] Subtest sysfs-reader: SUCCESS (3.897s) [477.285436] [109/133] (545s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [477.380974] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [478.161525] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.803s) [478.338992] [110/133] (544s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [478.446781] Starting subtest: primary-yf-tiled-reflect-x-90 [478.454464] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [478.513826] [111/133] (544s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [478.569961] Starting subtest: invalid-multi-wait-unsubmitted-signaled [478.572078] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [478.664025] [112/133] (544s left) kms_psr (psr-sprite-mmap-gtt) [478.749845] Starting subtest: psr-sprite-mmap-gtt [478.752047] Starting dynamic subtest: eDP-1 [480.216217] Dynamic subtest eDP-1: SKIP (1.497s) [480.220697] Subtest psr-sprite-mmap-gtt: SKIP (1.499s) [480.371053] [113/133] (542s left) kms_draw_crc (draw-method-blt) [480.463354] Starting subtest: draw-method-blt [480.465472] Starting dynamic subtest: xrgb8888-untiled [480.690499] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s) [480.699064] Starting dynamic subtest: rgb565-untiled [480.919597] Dynamic subtest rgb565-untiled: SUCCESS (0.233s) [480.929113] Starting dynamic subtest: xrgb2101010-untiled [481.140085] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [481.149124] Starting dynamic subtest: xbgr16161616f-untiled [481.366345] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.231s) [481.374871] Starting dynamic subtest: xrgb8888-xtiled [481.475356] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s) [481.483482] Starting dynamic subtest: rgb565-xtiled [481.584373] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [481.592723] Starting dynamic subtest: xrgb2101010-xtiled [481.693636] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [481.702138] Starting dynamic subtest: xbgr16161616f-xtiled [481.802743] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s) [481.811977] Starting dynamic subtest: xrgb8888-4tiled [481.912278] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s) [481.923516] Starting dynamic subtest: rgb565-4tiled [482.032565] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s) [482.044042] Starting dynamic subtest: xrgb2101010-4tiled [482.152721] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.120s) [482.161198] Starting dynamic subtest: xbgr16161616f-4tiled [482.261953] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s) [482.263801] Subtest draw-method-blt: SUCCESS (1.833s) [482.386407] [114/133] (540s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [482.500171] Starting subtest: 2x-cursor-vs-flip-legacy [482.503843] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s) [482.658147] [115/133] (540s left) gem_partial_pwrite_pread (writes-after-reads-display) [482.718416] Subtest writes-after-reads-display: SKIP (0.000s) [482.780831] [116/133] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [482.864373] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [482.867723] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [482.974738] [117/133] (540s left) kms_properties (plane-properties-atomic) [483.067871] Starting subtest: plane-properties-atomic [483.069843] Starting dynamic subtest: pipe-A-eDP-1 [483.616607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s) [483.626691] Starting dynamic subtest: pipe-B-eDP-1 [484.915701] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.314s) [484.925020] Starting dynamic subtest: pipe-C-eDP-1 [486.150554] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.245s) [486.160183] Starting dynamic subtest: pipe-D-eDP-1 [487.384811] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s) [487.387159] Subtest plane-properties-atomic: SUCCESS (4.365s) [488.177899] [118/133] (534s left) gem_exec_params (secure-non-root) [488.246504] Starting subtest: secure-non-root [488.250871] Subtest secure-non-root: SKIP (0.000s) [488.356959] [119/133] (534s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [488.448499] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [488.452628] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [488.523830] [120/133] (534s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [488.643800] Starting subtest: cursorA-vs-flipA-atomic [499.716650] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.124s) [500.549199] [121/133] (522s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [500.660201] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [500.662542] Starting dynamic subtest: pipe-A-eDP-1 [500.683681] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [500.694484] Starting dynamic subtest: pipe-B-eDP-1 [500.714199] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [500.722566] Starting dynamic subtest: pipe-C-eDP-1 [500.741562] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [500.750174] Starting dynamic subtest: pipe-D-eDP-1 [500.769780] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [500.772073] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s) [502.843331] [122/133] (520s left) kms_pm_rpm (system-suspend-idle) [505.078966] Starting subtest: system-suspend-idle [524.774904] Subtest system-suspend-idle: SUCCESS (4.709s) [525.174705] [123/133] (498s left) kms_flip (flip-vs-dpms-off-vs-modeset) [525.280773] Starting subtest: flip-vs-dpms-off-vs-modeset [525.282974] Starting dynamic subtest: A-eDP1 [528.837713] Dynamic subtest A-eDP1: SUCCESS (3.621s) [528.848234] Starting dynamic subtest: B-eDP1 [532.028982] Dynamic subtest B-eDP1: SUCCESS (3.230s) [532.048125] Starting dynamic subtest: C-eDP1 [535.135773] Dynamic subtest C-eDP1: SUCCESS (3.131s) [535.145957] Starting dynamic subtest: D-eDP1 [538.203333] Dynamic subtest D-eDP1: SUCCESS (3.085s) [538.205758] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.077s) [539.012537] [124/133] (484s left) prime_vgem (coherency-gtt) [539.098514] Starting subtest: coherency-gtt [539.103847] Subtest coherency-gtt: SKIP (0.000s) [539.191918] [125/133] (484s left) kms_selftest (drm_dp_mst_helper) [539.229801] Starting subtest: drm_dp_mst_helper [539.247384] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [539.341995] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.096s) [539.353565] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [539.450906] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.109s) [539.460625] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [539.559976] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.109s) [539.562581] Subtest drm_dp_mst_helper: SUCCESS (0.335s) [539.707694] [126/133] (483s left) gem_softpin (evict-active) [539.761200] Starting subtest: evict-active [539.769250] Subtest evict-active: SUCCESS (0.008s) [539.880085] [127/133] (483s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [539.971871] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [539.973996] Starting dynamic subtest: pipe-A-eDP-1 [540.069973] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [540.080310] Starting dynamic subtest: pipe-B-eDP-1 [541.180394] Dynamic subtest pipe-B-eDP-1: SKIP (1.108s) [541.186290] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.211s) [542.361241] [128/133] (481s left) kms_psr (fbc-pr-sprite-render) [542.451765] Starting subtest: fbc-pr-sprite-render [542.457022] Subtest fbc-pr-sprite-render: SKIP (0.000s) [542.526310] [129/133] (481s left) gem_caching (read-writes) [542.598732] Subtest read-writes: SKIP (0.000s) [542.677609] [130/133] (480s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [542.795706] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [560.629735] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.850s) [561.504387] [131/133] (462s left) gem_mmap_offset (partial-unmap) [561.568554] Starting subtest: partial-unmap [561.570851] Starting dynamic subtest: smem0 [562.076178] Dynamic subtest smem0: SUCCESS (0.509s) [562.078893] Subtest partial-unmap: SUCCESS (0.510s) [562.170666] [132/133] (461s left) kms_content_protection (atomic-dpms) [562.316477] Starting subtest: atomic-dpms [562.321874] Subtest atomic-dpms: SKIP (0.000s) [562.429347] [133/133] (461s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [562.807537] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [563.613336] Closing watchdogs results: parsing output: 0/ for test: gem_spin_batch results: parsing output: 1/ for test: kms_cursor_crc results: parsing output: 2/ for test: kms_invalid_mode results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_fence results: parsing output: 5/ for test: kms_cursor_crc results: parsing output: 6/ for test: gem_exec_params results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: kms_ccs results: parsing output: 9/ for test: kms_cursor_legacy results: parsing output: 10/ for test: kms_ccs results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gem_softpin results: parsing output: 13/ for test: gem_mmap_gtt results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: kms_vrr results: parsing output: 16/ for test: gem_ctx_persistence results: parsing output: 17/ for test: kms_cursor_edge_walk results: parsing output: 18/ for test: gem_lmem_swapping results: parsing output: 19/ for test: kms_flip_scaled_crc results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: syncobj_eventfd results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_exec_schedule results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_atomic results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: drm_read results: parsing output: 29/ for test: syncobj_wait results: parsing output: 30/ for test: gem_pxp results: parsing output: 31/ for test: gem_mmap_wc results: parsing output: 32/ for test: gem_exec_reloc results: parsing output: 33/ for test: dmabuf_sync_file results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: i915_drm_fdinfo results: parsing output: 36/ for test: kms_plane_cursor results: parsing output: 37/ for test: kms_chamelium_hpd results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: kms_lease results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: gem_create results: parsing output: 43/ for test: dumb_buffer results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_psr2_sf results: parsing output: 48/ for test: gem_ctx_isolation results: parsing output: 49/ for test: kms_plane_scaling results: parsing output: 50/ for test: kms_color results: parsing output: 51/ for test: kms_pm_rpm results: parsing output: 52/ for test: gem_mmap_gtt results: parsing output: 53/ for test: kms_cursor_legacy results: parsing output: 54/ for test: i915_pm_rpm results: parsing output: 55/ for test: gen9_exec_parse results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: gem_wait results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: kms_plane results: parsing output: 61/ for test: gem_exec_balancer results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_big_fb results: parsing output: 65/ for test: kms_cdclk results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_busy results: parsing output: 68/ for test: perf_pmu results: parsing output: 69/ for test: gem_exec_balancer results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: vgem_basic results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_flink_basic results: parsing output: 75/ for test: gem_exec_schedule results: parsing output: 76/ for test: perf results: parsing output: 77/ for test: gem_fence_thrash results: parsing output: 78/ for test: syncobj_wait results: parsing output: 79/ for test: kms_rmfb results: parsing output: 80/ for test: gem_ctx_shared results: parsing output: 81/ for test: gem_gtt_cpu_tlb results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_ppgtt results: parsing output: 84/ for test: api_intel_bb results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: gem_exec_reloc results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_ccs results: parsing output: 91/ for test: kms_rotation_crc results: parsing output: 92/ for test: kms_hdr results: parsing output: 93/ for test: kms_async_flips results: parsing output: 94/ for test: gem_exec_schedule results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_softpin results: parsing output: 97/ for test: kms_vrr results: parsing output: 98/ for test: gem_exec_reloc results: parsing output: 99/ for test: gem_exec_params results: parsing output: 100/ for test: kms_flip results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: i915_query results: parsing output: 103/ for test: api_intel_allocator results: parsing output: 104/ for test: i915_module_load results: parsing output: 105/ for test: kms_properties results: parsing output: 106/ for test: kms_plane_scaling results: parsing output: 107/ for test: i915_suspend results: parsing output: 108/ for test: kms_big_fb results: parsing output: 109/ for test: kms_rotation_crc results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: kms_draw_crc results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: gem_partial_pwrite_pread results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_properties results: parsing output: 117/ for test: gem_exec_params results: parsing output: 118/ for test: kms_plane results: parsing output: 119/ for test: kms_cursor_legacy results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: kms_pm_rpm results: parsing output: 122/ for test: kms_flip results: parsing output: 123/ for test: prime_vgem results: parsing output: 124/ for test: kms_selftest results: parsing output: 125/ for test: gem_softpin results: parsing output: 126/ for test: kms_psr2_sf results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: gem_caching results: parsing output: 129/ for test: kms_cursor_legacy results: parsing output: 130/ for test: gem_mmap_offset results: parsing output: 131/ for test: kms_content_protection results: parsing output: 132/ for test: kms_chamelium_edid Done.