[58.437775] Initializing watchdogs [58.437894] /dev/watchdog0 [58.452171] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.456404] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.458818] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.462199] [001/131] (960s left) kms_cursor_crc (cursor-random-512x512) [58.778627] Starting subtest: cursor-random-512x512 [58.783253] Subtest cursor-random-512x512: SKIP (0.001s) [58.920597] [002/131] (960s left) kms_properties (plane-properties-atomic) [59.011890] Starting subtest: plane-properties-atomic [59.014166] Starting dynamic subtest: pipe-A-eDP-1 [59.599841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s) [59.607562] Starting dynamic subtest: pipe-B-eDP-1 [60.875395] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.274s) [60.883891] Starting dynamic subtest: pipe-C-eDP-1 [62.090338] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s) [62.097918] Starting dynamic subtest: pipe-D-eDP-1 [63.319205] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s) [63.321192] Subtest plane-properties-atomic: SUCCESS (4.304s) [64.104270] [003/131] (954s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt) [64.211453] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt [64.215464] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [64.308568] [004/131] (954s left) syncobj_wait (wait-any-interrupted) [64.363696] Starting subtest: wait-any-interrupted [64.471964] Subtest wait-any-interrupted: SUCCESS (0.106s) [64.538839] [005/131] (954s left) gen7_exec_parse (chained-batch) [64.602916] Subtest chained-batch: SKIP (0.000s) [64.665735] [006/131] (954s left) gem_mmap_gtt (cpuset-big-copy-odd) [64.729130] Subtest cpuset-big-copy-odd: SKIP (0.000s) [64.777372] [007/131] (954s left) i915_query (hwconfig_table) [64.835750] Starting subtest: hwconfig_table [65.134031] Subtest hwconfig_table: SUCCESS (0.001s) [65.163212] [008/131] (954s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [65.258084] Starting subtest: plane-upscale-20x20-with-rotation [65.260345] Starting dynamic subtest: pipe-A [65.484407] Dynamic subtest pipe-A: SUCCESS (0.226s) [65.492157] Starting dynamic subtest: pipe-B [66.791855] Dynamic subtest pipe-B: SUCCESS (1.307s) [66.800111] Starting dynamic subtest: pipe-C [68.116372] Dynamic subtest pipe-C: SUCCESS (1.324s) [68.122850] Starting dynamic subtest: pipe-D [69.445426] Dynamic subtest pipe-D: SUCCESS (1.329s) [69.447744] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.188s) [70.611199] [009/131] (948s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [70.706188] Starting subtest: invalidate-primary-flip-overlay [81.583651] Subtest invalidate-primary-flip-overlay: SUCCESS (10.878s) [81.747151] [010/131] (937s left) kms_force_connector_basic (force-edid) [81.830260] Starting subtest: force-edid [82.165016] Subtest force-edid: SUCCESS (0.335s) [82.318744] [011/131] (936s left) kms_addfb_basic (bad-pitch-65536) [82.370089] Starting subtest: bad-pitch-65536 [82.371898] Subtest bad-pitch-65536: SUCCESS (0.000s) [82.516784] [012/131] (936s left) kms_getfb (getfb-handle-valid) [82.577420] Starting subtest: getfb-handle-valid [82.579531] Subtest getfb-handle-valid: SUCCESS (0.000s) [82.678185] [013/131] (936s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [82.770628] Starting subtest: compare-crc-sanitycheck-nv12 [82.772695] Starting dynamic subtest: pipe-A-eDP-1 [83.453920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.682s) [83.463541] Starting dynamic subtest: pipe-B-eDP-1 [84.643847] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.187s) [84.652725] Starting dynamic subtest: pipe-C-eDP-1 [85.805831] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.162s) [85.814592] Starting dynamic subtest: pipe-D-eDP-1 [87.006890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s) [87.009272] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.233s) [87.826278] [014/131] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [87.931747] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [92.472556] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.544s) [92.614745] [015/131] (926s left) gem_close_race (multigpu-basic-threads) [92.683769] Starting subtest: multigpu-basic-threads [92.688262] Subtest multigpu-basic-threads: SKIP (0.000s) [92.903583] [016/131] (926s left) kms_flip (2x-plain-flip-fb-recreate) [93.009363] Starting subtest: 2x-plain-flip-fb-recreate [93.020370] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s) [93.148139] [017/131] (926s left) gem_exec_schedule (pi-common) [93.336817] Starting subtest: pi-common [93.338860] Starting dynamic subtest: rcs0 [93.440607] Dynamic subtest rcs0: SUCCESS (0.106s) [93.453174] Starting dynamic subtest: bcs0 [93.515270] Dynamic subtest bcs0: SUCCESS (0.074s) [93.529043] Starting dynamic subtest: vcs0 [93.592488] Dynamic subtest vcs0: SUCCESS (0.076s) [93.606611] Starting dynamic subtest: vcs1 [93.665531] Dynamic subtest vcs1: SUCCESS (0.073s) [93.680190] Starting dynamic subtest: vecs0 [93.740815] Dynamic subtest vecs0: SUCCESS (0.074s) [93.754685] Starting dynamic subtest: ccs0 [93.814596] Dynamic subtest ccs0: SUCCESS (0.073s) [93.817325] Subtest pi-common: SUCCESS (0.480s) [94.061024] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true [94.064297] [018/131] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [94.170531] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [94.174570] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [94.281102] [019/131] (925s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf) [99.304102] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf [99.306105] Starting dynamic subtest: pipe-A-eDP-1 [116.463427] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.160s) [116.471769] Starting dynamic subtest: pipe-B-eDP-1 [133.674196] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.206s) [133.677139] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.371s) [134.522256] [020/131] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [134.619480] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [134.624095] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [134.703292] [021/131] (884s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [134.819594] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [136.054328] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.237s) [136.440624] [022/131] (883s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [136.538112] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [136.540560] Starting dynamic subtest: pipe-A [136.612925] Dynamic subtest pipe-A: SUCCESS (0.075s) [136.621082] Starting dynamic subtest: pipe-B [137.723474] Dynamic subtest pipe-B: SUCCESS (1.110s) [137.733069] Starting dynamic subtest: pipe-C [138.803035] Dynamic subtest pipe-C: SUCCESS (1.079s) [138.811409] Starting dynamic subtest: pipe-D [139.901541] Dynamic subtest pipe-D: SUCCESS (1.098s) [139.903867] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.364s) [141.024351] [023/131] (878s left) gem_mmap_gtt (basic-small-copy-odd) [141.091736] Subtest basic-small-copy-odd: SKIP (0.000s) [141.148304] [024/131] (878s left) gem_mmap_wc (invalid-flags) [141.210306] Subtest invalid-flags: SKIP (0.000s) [141.271488] [025/131] (878s left) gem_exec_params (dr4-dirt) [141.338693] Starting subtest: DR4-dirt [141.341091] Subtest DR4-dirt: SUCCESS (0.000s) [141.449610] [026/131] (878s left) gem_exec_balancer (indices) [141.525372] Starting subtest: indices [143.880135] Subtest indices: SUCCESS (2.353s) [144.175272] [027/131] (875s left) kms_cursor_legacy (single-move) [144.308971] Starting subtest: single-move [144.311255] Starting dynamic subtest: pipe-A [149.693268] Dynamic subtest pipe-A: SUCCESS (5.380s) [149.703224] Starting dynamic subtest: pipe-B [155.078898] Dynamic subtest pipe-B: SUCCESS (5.384s) [155.088251] Starting dynamic subtest: pipe-C [160.464346] Dynamic subtest pipe-C: SUCCESS (5.383s) [160.473825] Starting dynamic subtest: pipe-D [165.847031] Dynamic subtest pipe-D: SUCCESS (5.381s) [165.856347] Starting dynamic subtest: all-pipes [171.237687] Dynamic subtest all-pipes: SUCCESS (5.388s) [171.240100] Subtest single-move: SUCCESS (26.923s) [171.362072] [028/131] (848s left) kms_addfb_basic (too-high) [171.458378] Starting subtest: too-high [171.460851] Subtest too-high: SUCCESS (0.000s) [171.560465] [029/131] (848s left) gem_mmap_offset (ptrace) [171.614246] Starting subtest: ptrace [171.616567] Starting dynamic subtest: smem0-wb [171.637229] Dynamic subtest smem0-wb: SUCCESS (0.022s) [171.644161] Starting dynamic subtest: smem0-wc [171.654343] Dynamic subtest smem0-wc: SUCCESS (0.017s) [171.661128] Starting dynamic subtest: smem0-uc [171.672087] Dynamic subtest smem0-uc: SUCCESS (0.017s) [171.674304] Subtest ptrace: SUCCESS (0.060s) [171.801852] [030/131] (848s left) gem_exec_fence (invalid-timeline-fence-array) [172.341207] Starting subtest: invalid-timeline-fence-array [172.347789] Subtest invalid-timeline-fence-array: SUCCESS (0.005s) [174.022146] [031/131] (845s left) gem_softpin (evict-prime) [174.091526] Starting subtest: evict-prime [174.093781] Starting dynamic subtest: rcs0 [175.293454] Dynamic subtest rcs0: SUCCESS (1.201s) [175.307369] Starting dynamic subtest: bcs0 [176.449865] Dynamic subtest bcs0: SUCCESS (1.155s) [176.459211] Starting dynamic subtest: vcs0 [177.996341] Dynamic subtest vcs0: SUCCESS (1.544s) [178.007596] Starting dynamic subtest: vcs1 [179.975867] Dynamic subtest vcs1: SUCCESS (1.978s) [179.987063] Starting dynamic subtest: vecs0 [181.960771] Dynamic subtest vecs0: SUCCESS (1.984s) [181.973934] Starting dynamic subtest: ccs0 [183.122896] Dynamic subtest ccs0: SUCCESS (1.162s) [183.133561] Starting dynamic subtest: all [184.968312] Dynamic subtest all: SUCCESS (1.843s) [184.970951] Subtest evict-prime: SUCCESS (10.875s) [185.042252] [032/131] (834s left) i915_pm_rpm (system-suspend-devices) [187.092735] Starting subtest: system-suspend-devices [194.704499] Subtest system-suspend-devices: SUCCESS (7.612s) [195.068740] [033/131] (824s left) gem_exec_suspend (basic-s0) [195.127549] Starting subtest: basic-S0 [195.129993] Starting dynamic subtest: smem [215.889579] Dynamic subtest smem: SUCCESS (6.770s) [215.892689] Subtest basic-S0: SUCCESS (6.771s) [216.070982] [034/131] (817s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [216.191147] Starting subtest: cursorA-vs-flipB-atomic-transitions [216.195652] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [216.320865] [035/131] (817s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [216.442613] Starting subtest: 2x-flip-vs-cursor-legacy [216.447111] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [216.568060] [036/131] (817s left) gem_exec_reloc (basic-write-read) [216.630625] Subtest basic-write-read: SKIP (0.000s) [216.704206] [037/131] (817s left) kms_psr (fbc-psr-dpms) [216.795745] Starting subtest: fbc-psr-dpms [216.798047] Starting dynamic subtest: eDP-1 [216.802184] Dynamic subtest eDP-1: SKIP (0.000s) [216.806327] Subtest fbc-psr-dpms: SKIP (0.001s) [216.864293] [038/131] (817s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [216.967545] Starting subtest: modeset-transition-nonblocking-fencing [216.969767] Starting dynamic subtest: 1x-outputs [227.616460] Dynamic subtest 1x-outputs: SUCCESS (10.650s) [227.892782] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.924s) [228.711434] [039/131] (805s left) kms_invalid_mode (bad-vtotal) [228.815604] Starting subtest: bad-vtotal [228.817929] Starting dynamic subtest: pipe-A-eDP-1 [229.097032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s) [229.106448] Starting dynamic subtest: pipe-B-eDP-1 [229.108286] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [229.115710] Starting dynamic subtest: pipe-C-eDP-1 [229.118044] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [229.125864] Starting dynamic subtest: pipe-D-eDP-1 [229.128191] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [229.130993] Subtest bad-vtotal: SUCCESS (0.286s) [229.911037] [040/131] (804s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [230.011247] Starting subtest: primary-y-tiled-reflect-x-270 [230.016033] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [230.082227] [041/131] (804s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [230.178720] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [230.180988] Starting dynamic subtest: pipe-A-eDP-1 [230.189951] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [230.199628] Starting dynamic subtest: pipe-B-eDP-1 [230.208441] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [230.215962] Starting dynamic subtest: pipe-C-eDP-1 [230.224517] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [230.232054] Starting dynamic subtest: pipe-D-eDP-1 [230.240707] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [230.244809] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s) [232.412944] [042/131] (801s left) kms_plane (pixel-format-source-clamping) [232.506713] Starting subtest: pixel-format-source-clamping [232.544120] Starting dynamic subtest: pipe-A-plane-0 [237.276847] Dynamic subtest pipe-A-plane-0: SUCCESS (4.733s) [237.285926] Starting dynamic subtest: pipe-A-plane-3 [239.487931] Dynamic subtest pipe-A-plane-3: SUCCESS (2.211s) [239.501004] Starting dynamic subtest: pipe-A-plane-5 [239.502908] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s) [240.576305] Starting dynamic subtest: pipe-B-plane-0 [245.235154] Dynamic subtest pipe-B-plane-0: SUCCESS (4.667s) [245.243719] Starting dynamic subtest: pipe-B-plane-3 [247.468433] Dynamic subtest pipe-B-plane-3: SUCCESS (2.233s) [247.476731] Starting dynamic subtest: pipe-B-plane-5 [247.478619] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s) [247.779632] Subtest pixel-format-source-clamping: SUCCESS (15.271s) [248.610758] [043/131] (785s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [248.709663] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [248.711929] Starting dynamic subtest: pipe-A-default-mode [251.372444] Dynamic subtest pipe-A-default-mode: SUCCESS (2.659s) [251.374808] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.660s) [252.210913] [044/131] (782s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [252.315773] Starting subtest: yf-tiled-64bpp-rotate-180 [252.319862] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [252.417903] [045/131] (781s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [252.521438] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [252.523704] Starting dynamic subtest: pipe-A-eDP-1 [252.543635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [252.553689] Starting dynamic subtest: pipe-B-eDP-1 [252.572764] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [252.580037] Starting dynamic subtest: pipe-C-eDP-1 [252.599510] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [252.607235] Starting dynamic subtest: pipe-D-eDP-1 [252.626898] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [252.628824] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [254.713643] [046/131] (779s left) gem_render_linear_blits (basic) [254.771461] Starting subtest: basic [254.792348] Subtest basic: SUCCESS (0.021s) [254.870135] [047/131] (779s left) kms_big_fb (linear-64bpp-rotate-0) [254.969869] Starting subtest: linear-64bpp-rotate-0 [257.234576] Subtest linear-64bpp-rotate-0: SUCCESS (2.266s) [257.511986] [048/131] (777s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [257.625935] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [257.629973] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [257.744226] [049/131] (776s left) kms_psr (psr-primary-render) [257.852216] Starting subtest: psr-primary-render [257.854454] Starting dynamic subtest: eDP-1 [259.586232] Dynamic subtest eDP-1: SUCCESS (1.735s) [259.588665] Subtest psr-primary-render: SUCCESS (1.736s) [260.410754] [050/131] (774s left) gem_render_copy_redux (interruptible) [260.463751] Starting subtest: interruptible [260.829729] Subtest interruptible: SUCCESS (0.366s) [260.975811] [051/131] (773s left) gem_exec_params (sol-reset-not-gen7) [261.042192] Starting subtest: sol-reset-not-gen7 [261.044527] Subtest sol-reset-not-gen7: SUCCESS (0.003s) [261.177160] [052/131] (773s left) kms_color (gamma) [261.277451] Starting subtest: gamma [261.279641] Starting dynamic subtest: pipe-A-eDP-1 [261.980960] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s) [261.989609] Starting dynamic subtest: pipe-B-eDP-1 [263.393739] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s) [263.403033] Starting dynamic subtest: pipe-C-eDP-1 [264.717140] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.322s) [264.726401] Starting dynamic subtest: pipe-D-eDP-1 [266.044548] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s) [266.046814] Subtest gamma: SUCCESS (4.767s) [266.914582] [053/131] (767s left) kms_big_fb (y-tiled-16bpp-rotate-270) [267.036739] Starting subtest: y-tiled-16bpp-rotate-270 [267.041044] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [267.145360] [054/131] (767s left) kms_dsc (dsc-with-output-formats) [267.235382] Starting subtest: dsc-with-output-formats [267.256547] Subtest dsc-with-output-formats: SKIP (0.001s) [267.302838] [055/131] (767s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [267.682251] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [268.489775] [056/131] (766s left) kms_content_protection (atomic-dpms) [268.660880] Starting subtest: atomic-dpms [271.966492] Subtest atomic-dpms: SKIP (3.303s) [273.106738] [057/131] (761s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [278.191039] Starting subtest: fbc-pr-cursor-plane-update-sf [278.199173] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.005s) [279.010081] [058/131] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite) [279.125986] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite [284.181721] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (5.058s) [284.323038] [059/131] (750s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [284.440649] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [289.542492] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.105s) [289.682901] [060/131] (745s left) gem_exec_whisper (basic-sync-all) [289.761215] Starting subtest: basic-sync-all [295.418074] Subtest basic-sync-all: SUCCESS (5.655s) [295.597571] [061/131] (739s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [295.717005] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [295.721263] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [295.802125] [062/131] (739s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [295.902198] Starting subtest: fbcpsr-rgb101010-draw-render [300.549730] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.649s) [300.659253] [063/131] (734s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [300.786110] Starting subtest: 2x-long-cursor-vs-flip-legacy [300.790551] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [300.923139] [064/131] (734s left) gem_exec_fence (syncobj-invalid-wait) [301.365036] Starting subtest: syncobj-invalid-wait [301.367531] Subtest syncobj-invalid-wait: SUCCESS (0.000s) [303.038374] [065/131] (732s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [303.143521] Starting subtest: fbcpsr-tiling-4 [307.983203] Subtest fbcpsr-tiling-4: SUCCESS (4.843s) [308.113190] [066/131] (727s left) gem_softpin (invalid) [308.174134] Starting subtest: invalid [308.181622] Subtest invalid: SUCCESS (0.006s) [308.308333] [067/131] (726s left) kms_universal_plane (disable-primary-vs-flip) [308.414466] Starting subtest: disable-primary-vs-flip [308.416830] Starting dynamic subtest: pipe-A-eDP-1 [309.936593] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.520s) [309.947126] Starting dynamic subtest: pipe-B-eDP-1 [312.146200] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.208s) [312.156103] Starting dynamic subtest: pipe-C-eDP-1 [314.343155] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.195s) [314.352681] Starting dynamic subtest: pipe-D-eDP-1 [316.550537] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.202s) [316.552976] Subtest disable-primary-vs-flip: SUCCESS (8.130s) [317.407173] [068/131] (717s left) kms_chamelium_frames (dp-crc-single) [317.786723] Subtest dp-crc-single: SKIP (0.000s) [318.583824] [069/131] (716s left) kms_psr (pr-cursor-mmap-cpu) [318.681431] Starting subtest: pr-cursor-mmap-cpu [318.685571] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [318.738986] [070/131] (716s left) gem_gtt_cpu_tlb [318.848588] [071/131] (716s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [318.955528] Starting subtest: psr-rgb101010-draw-mmap-wc [323.843735] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.890s) [323.940106] [072/131] (711s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [323.993864] Starting subtest: multi-wait-all-for-submit-available-submitted [323.996155] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [324.095911] [073/131] (711s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [324.196530] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [324.198830] Starting dynamic subtest: pipe-A-eDP-1 [324.221580] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [324.231988] Starting dynamic subtest: pipe-B-eDP-1 [324.253982] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [324.263145] Starting dynamic subtest: pipe-C-eDP-1 [324.285506] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [324.294896] Starting dynamic subtest: pipe-D-eDP-1 [324.317218] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [324.321913] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s) [326.417608] [074/131] (709s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [326.512486] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [326.514823] Starting dynamic subtest: pipe-A-eDP-1 [326.538563] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [326.547429] Starting dynamic subtest: pipe-B-eDP-1 [326.569447] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [326.577413] Starting dynamic subtest: pipe-C-eDP-1 [326.598998] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [326.606818] Starting dynamic subtest: pipe-D-eDP-1 [326.628690] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [326.633155] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [328.717338] [075/131] (706s left) gem_ctx_persistence (hostile) [328.772254] Starting subtest: hostile [338.917255] Subtest hostile: SUCCESS (10.138s) [339.054852] [076/131] (696s left) gem_mmap_gtt (big-copy) [339.114121] Subtest big-copy: SKIP (0.000s) [339.192849] [077/131] (696s left) gem_exec_reloc (basic-wc-cpu-noreloc) [339.252253] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [339.308248] [078/131] (696s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [339.431258] Starting subtest: 2x-long-flip-vs-cursor-legacy [339.435717] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [339.560357] [079/131] (696s left) kms_psr (pr-sprite-blt) [339.670644] Starting subtest: pr-sprite-blt [339.674553] Subtest pr-sprite-blt: SKIP (0.000s) [339.736464] [080/131] (695s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [339.848150] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [339.852331] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [339.956299] [081/131] (695s left) gem_ctx_sseu (mmap-args) [340.023320] Subtest mmap-args: SKIP (0.000s) [340.115948] [082/131] (695s left) gem_mmap_gtt (basic-small-bo-tiledx) [340.186306] Subtest basic-small-bo-tiledX: SKIP (0.000s) [340.253056] [083/131] (695s left) gem_pwrite (basic-self) [340.318211] Subtest basic-self: SKIP (0.000s) [340.380976] [084/131] (695s left) kms_pipe_crc_basic (suspend-read-crc) [340.489059] Starting subtest: suspend-read-crc [340.490953] Starting dynamic subtest: pipe-A-eDP-1 [357.872858] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.541s) [357.881872] Starting dynamic subtest: pipe-B-eDP-1 [375.587835] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.823s) [375.596731] Starting dynamic subtest: pipe-C-eDP-1 [393.589217] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.782s) [393.598120] Starting dynamic subtest: pipe-D-eDP-1 [411.550223] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.708s) [411.552713] Subtest suspend-read-crc: SUCCESS (10.859s) [412.397010] [085/131] (683s left) device_reset (unbind-reset-rebind) [412.445621] Starting subtest: unbind-reset-rebind [417.052932] Subtest unbind-reset-rebind: SUCCESS (4.595s) [417.103807] [086/131] (679s left) kms_psr (fbc-pr-sprite-mmap-gtt) [417.204999] Starting subtest: fbc-pr-sprite-mmap-gtt [417.209518] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [417.273787] [087/131] (678s left) perf_pmu (busy-accuracy-2) [417.313071] Starting subtest: busy-accuracy-2 [417.315342] Starting dynamic subtest: rcs0 [420.361438] Dynamic subtest rcs0: SUCCESS (3.043s) [420.370348] Starting dynamic subtest: bcs0 [423.424075] Dynamic subtest bcs0: SUCCESS (3.059s) [423.435075] Starting dynamic subtest: vcs0 [426.474458] Dynamic subtest vcs0: SUCCESS (3.048s) [426.483197] Starting dynamic subtest: vcs1 [429.526785] Dynamic subtest vcs1: SUCCESS (3.048s) [429.538498] Starting dynamic subtest: vecs0 [432.577895] Dynamic subtest vecs0: SUCCESS (3.049s) [432.587469] Starting dynamic subtest: ccs0 [435.642778] Dynamic subtest ccs0: SUCCESS (3.060s) [435.645522] Subtest busy-accuracy-2: SUCCESS (18.316s) [435.751806] [088/131] (660s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [435.856630] Starting subtest: plane-primary-toggle-with-vblank-wait [435.858959] Starting dynamic subtest: pipe-A-eDP-1 [436.017773] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.159s) [436.315829] Starting dynamic subtest: pipe-B-eDP-1 [437.200649] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.892s) [437.487236] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.629s) [438.349680] [089/131] (657s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [438.464564] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [439.299652] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.836s) [439.499981] [090/131] (656s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [439.607614] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [439.610073] Starting dynamic subtest: pipe-A-default-mode [439.896485] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [439.901205] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.284s) [440.673560] [091/131] (655s left) i915_pm_rpm (debugfs-forcewake-user) [442.221225] Starting subtest: debugfs-forcewake-user [453.611819] Subtest debugfs-forcewake-user: SUCCESS (11.386s) [453.964076] [092/131] (642s left) kms_chamelium_audio (dp-audio-edid) [454.338515] Subtest dp-audio-edid: SKIP (0.000s) [455.157824] [093/131] (641s left) sysfs_heartbeat_interval (invalid) [455.209980] Starting subtest: invalid [455.212399] Starting dynamic subtest: vecs0 [455.214968] Dynamic subtest vecs0: SUCCESS (0.000s) [455.225966] Starting dynamic subtest: ccs0 [455.228293] Dynamic subtest ccs0: SUCCESS (0.000s) [455.237017] Starting dynamic subtest: vcs0 [455.239320] Dynamic subtest vcs0: SUCCESS (0.000s) [455.248130] Starting dynamic subtest: bcs0 [455.250432] Dynamic subtest bcs0: SUCCESS (0.000s) [455.259454] Starting dynamic subtest: rcs0 [455.261961] Dynamic subtest rcs0: SUCCESS (0.000s) [455.272634] Starting dynamic subtest: vcs1 [455.274993] Dynamic subtest vcs1: SUCCESS (0.000s) [455.276944] Subtest invalid: SUCCESS (0.005s) [455.330213] [094/131] (641s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [460.356772] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [460.358798] Starting dynamic subtest: pipe-A-eDP-1 [461.136093] Dynamic subtest pipe-A-eDP-1: SKIP (0.777s) [461.146085] Starting dynamic subtest: pipe-B-eDP-1 [462.263100] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [462.267561] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.905s) [463.440497] [095/131] (633s left) perf (oa-formats) [463.551346] Starting subtest: oa-formats [463.553556] Starting dynamic subtest: 0-rcs0 [463.572720] Dynamic subtest 0-rcs0: SUCCESS (0.021s) [463.581710] Starting dynamic subtest: 1-vecs0 [463.606387] Dynamic subtest 1-vecs0: SUCCESS (0.033s) [463.608701] Subtest oa-formats: SUCCESS (0.056s) [463.653501] [096/131] (632s left) gem_tiled_partial_pwrite_pread (writes) [463.709565] Subtest writes: SKIP (0.000s) [463.767531] [097/131] (632s left) kms_addfb_basic (master-rmfb) [463.826154] Starting subtest: master-rmfb [463.828525] Subtest master-rmfb: SUCCESS (0.002s) [463.990086] [098/131] (632s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [464.061735] Starting subtest: x-tiled-to-vebox-yf-tiled [464.066559] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [464.236996] [099/131] (632s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [464.363712] Starting subtest: cursorA-vs-flipA-atomic-transitions [475.570142] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.202s) [476.375550] [100/131] (620s left) kms_cursor_legacy (cursor-vs-flip-legacy) [476.495780] Starting subtest: cursor-vs-flip-legacy [505.909962] Subtest cursor-vs-flip-legacy: SUCCESS (29.395s) [506.717391] [101/131] (590s left) kms_atomic_transition (plane-all-transition-nonblocking) [506.814580] Starting subtest: plane-all-transition-nonblocking [506.816854] Starting dynamic subtest: pipe-A-eDP-1 [509.320776] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s) [509.607649] Starting dynamic subtest: pipe-B-eDP-1 [512.852803] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.252s) [513.141127] Subtest plane-all-transition-nonblocking: SUCCESS (6.322s) [513.971179] [102/131] (582s left) syncobj_timeline (invalid-query-illegal-handle) [514.035281] Starting subtest: invalid-query-illegal-handle [514.037712] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [514.146766] [103/131] (582s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [514.240395] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [514.242601] Starting dynamic subtest: pipe-A-default-mode [514.527305] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [514.531894] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.284s) [515.393926] [104/131] (581s left) gem_ctx_isolation (dirty-switch) [515.453500] Starting subtest: dirty-switch [515.455434] Starting dynamic subtest: rcs0 [515.885216] Dynamic subtest rcs0: SUCCESS (0.434s) [515.895519] Starting dynamic subtest: bcs0 [516.349798] Dynamic subtest bcs0: SUCCESS (0.464s) [516.358444] Starting dynamic subtest: vcs0 [516.826956] Dynamic subtest vcs0: SUCCESS (0.476s) [516.839715] Starting dynamic subtest: vcs1 [518.626886] Dynamic subtest vcs1: SUCCESS (1.798s) [518.638041] Starting dynamic subtest: vecs0 [520.575236] Dynamic subtest vecs0: SUCCESS (1.946s) [520.587019] Starting dynamic subtest: ccs0 [522.582093] Dynamic subtest ccs0: SUCCESS (2.006s) [522.585316] Subtest dirty-switch: SUCCESS (7.128s) [522.834196] [105/131] (574s left) gen9_exec_parse (secure-batches) [522.895725] Subtest secure-batches: SKIP (0.000s) [522.976684] [106/131] (573s left) syncobj_timeline (wait-all-for-submit-snapshot) [523.035013] Starting subtest: wait-all-for-submit-snapshot [523.114731] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [523.186670] [107/131] (573s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [523.296595] Starting subtest: 2x-flip-vs-blocking-wf-vblank [523.312484] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s) [523.384746] [108/131] (573s left) gem_ctx_persistence (legacy-engines-hostile) [523.441838] Starting subtest: legacy-engines-hostile [523.444151] Starting dynamic subtest: render [523.590068] Dynamic subtest render: SUCCESS (0.147s) [523.600362] Starting dynamic subtest: bsd1 [523.712236] Dynamic subtest bsd1: SUCCESS (0.119s) [523.721824] Starting dynamic subtest: bsd2 [523.828740] Dynamic subtest bsd2: SUCCESS (0.113s) [523.840821] Starting dynamic subtest: blt [523.906315] Dynamic subtest blt: SUCCESS (0.076s) [523.916757] Starting dynamic subtest: vebox [524.045636] Dynamic subtest vebox: SUCCESS (0.138s) [524.047872] Subtest legacy-engines-hostile: SUCCESS (0.605s) [524.120274] [109/131] (572s left) api_intel_bb (blit-reloc-keep-cache) [524.182817] Starting subtest: blit-reloc-keep-cache [524.186492] Subtest blit-reloc-keep-cache: SKIP (0.001s) [524.301296] [110/131] (572s left) kms_vblank (wait-forked-hang) [524.387045] Starting subtest: wait-forked-hang [524.389091] Starting dynamic subtest: pipe-A-eDP-1 [538.862499] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.464s) [538.878423] Starting dynamic subtest: pipe-D-eDP-1 [563.890795] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s) [563.893233] Subtest wait-forked-hang: SUCCESS (39.484s) [564.671474] [111/131] (532s left) sw_sync (alloc_merge_fence) [564.708624] Starting subtest: alloc_merge_fence [564.710653] Subtest alloc_merge_fence: SUCCESS (0.000s) [564.758130] [112/131] (532s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [564.863827] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [564.867989] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [564.976282] [113/131] (532s left) perf_pmu (all-busy-check-all) [565.019826] Starting subtest: all-busy-check-all [566.127288] Subtest all-busy-check-all: SUCCESS (1.107s) [566.228771] [114/131] (530s left) gem_exec_params (readonly) [566.290781] Starting subtest: readonly [566.296443] Subtest readonly: SUCCESS (0.003s) [566.413746] [115/131] (530s left) drm_fdinfo (virtual-busy-hang) [566.457270] Starting subtest: virtual-busy-hang [566.461725] Subtest virtual-busy-hang: SKIP (0.000s) [566.512953] [116/131] (530s left) syncobj_timeline (device-signal-unordered) [566.573669] Starting subtest: device-signal-unordered [566.576073] Subtest device-signal-unordered: SUCCESS (0.000s) [566.674731] [117/131] (530s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [566.791869] Starting subtest: extended-modeset-hang-oldfb-with-reset [566.793871] Starting dynamic subtest: pipe-A [578.460495] Dynamic subtest pipe-A: SUCCESS (11.664s) [578.473935] Starting dynamic subtest: pipe-D [590.713422] Dynamic subtest pipe-D: SUCCESS (12.240s) [590.715906] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.911s) [591.496060] [118/131] (505s left) gem_softpin (safe-alignment) [591.569597] Starting subtest: safe-alignment [591.587376] Subtest safe-alignment: SUCCESS (0.018s) [593.175681] [119/131] (504s left) api_intel_bb (offset-control) [593.234748] Starting subtest: offset-control [593.240692] Subtest offset-control: SUCCESS (0.007s) [593.385779] [120/131] (504s left) kms_cursor_edge_walk (128x128-left-edge) [593.475411] Starting subtest: 128x128-left-edge [593.477598] Starting dynamic subtest: pipe-A-eDP-1 [596.955557] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s) [596.964654] Starting dynamic subtest: pipe-D-eDP-1 [600.086727] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s) [600.089063] Subtest 128x128-left-edge: SUCCESS (6.607s) [600.880604] [121/131] (496s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [601.003890] Starting subtest: flip-vs-cursor-crc-atomic [601.609188] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.606s) [602.411336] [122/131] (495s left) gem_exec_reloc (basic-gtt-read-noreloc) [602.472256] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [602.532507] [123/131] (495s left) gem_lmem_swapping (smem-oom) [602.579630] Subtest smem-oom: SKIP (0.000s) [602.621539] [124/131] (494s left) syncobj_timeline (reset-multiple-signaled) [602.678690] Starting subtest: reset-multiple-signaled [602.680709] Subtest reset-multiple-signaled: SUCCESS (0.000s) [602.781822] [125/131] (494s left) sriov_basic (enable-vfs-autoprobe-off) [602.840303] Starting subtest: enable-vfs-autoprobe-off [602.842756] Starting dynamic subtest: numvfs-1 [602.915749] Dynamic subtest numvfs-1: FAIL (0.016s) [602.925054] Starting dynamic subtest: numvfs-2 [602.998579] Dynamic subtest numvfs-2: FAIL (0.003s) [603.009085] Starting dynamic subtest: numvfs-3 [603.083001] Dynamic subtest numvfs-3: FAIL (0.003s) [603.093000] Starting dynamic subtest: numvfs-4 [603.166798] Dynamic subtest numvfs-4: FAIL (0.003s) [603.177761] Starting dynamic subtest: numvfs-5 [603.252271] Dynamic subtest numvfs-5: FAIL (0.003s) [603.262466] Starting dynamic subtest: numvfs-6 [603.335916] Dynamic subtest numvfs-6: FAIL (0.003s) [603.346964] Starting dynamic subtest: numvfs-7 [603.408906] Dynamic subtest numvfs-7: FAIL (0.004s) [603.417587] Starting dynamic subtest: numvfs-random [603.477068] Dynamic subtest numvfs-random: FAIL (0.004s) [603.486311] Starting dynamic subtest: numvfs-all [603.545121] Dynamic subtest numvfs-all: FAIL (0.507s) [603.547060] Subtest enable-vfs-autoprobe-off: FAIL (0.552s) [603.578884] [126/131] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [603.672339] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [603.675774] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [603.785404] [127/131] (493s left) kms_flip (modeset-vs-vblank-race) [603.885528] Starting subtest: modeset-vs-vblank-race [603.887509] Starting dynamic subtest: A-eDP1 [608.618033] Dynamic subtest A-eDP1: SUCCESS (4.728s) [608.628820] Starting dynamic subtest: B-eDP1 [613.313895] Dynamic subtest B-eDP1: SUCCESS (4.692s) [613.323554] Starting dynamic subtest: C-eDP1 [617.797325] Dynamic subtest C-eDP1: SUCCESS (4.479s) [617.809097] Starting dynamic subtest: D-eDP1 [622.505595] Dynamic subtest D-eDP1: SUCCESS (4.705s) [622.507973] Subtest modeset-vs-vblank-race: SUCCESS (18.614s) [623.648908] [128/131] (474s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [623.755649] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [623.759939] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [623.860134] [129/131] (473s left) kms_pm_rpm (dpms-non-lpsp) [625.398483] Starting subtest: dpms-non-lpsp [625.403705] Subtest dpms-non-lpsp: SKIP (0.001s) [626.181758] [130/131] (471s left) syncobj_basic (bad-fd-to-handle) [626.232274] Starting subtest: bad-fd-to-handle [626.234608] Subtest bad-fd-to-handle: SUCCESS (0.000s) [626.323096] [131/131] (471s left) perf_pmu (init-wait) [626.365400] Starting subtest: init-wait [626.367685] Starting dynamic subtest: rcs0 [626.369940] Dynamic subtest rcs0: SUCCESS (0.002s) [626.380074] Starting dynamic subtest: bcs0 [626.382278] Dynamic subtest bcs0: SUCCESS (0.001s) [626.391376] Starting dynamic subtest: vcs0 [626.393501] Dynamic subtest vcs0: SUCCESS (0.001s) [626.402504] Starting dynamic subtest: vcs1 [626.404739] Dynamic subtest vcs1: SUCCESS (0.001s) [626.413716] Starting dynamic subtest: vecs0 [626.416054] Dynamic subtest vecs0: SUCCESS (0.001s) [626.424681] Starting dynamic subtest: ccs0 [626.427028] Dynamic subtest ccs0: SUCCESS (0.000s) [626.429267] Subtest init-wait: SUCCESS (0.009s) [626.468414] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: kms_properties results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: syncobj_wait results: parsing output: 4/ for test: gen7_exec_parse results: parsing output: 5/ for test: gem_mmap_gtt results: parsing output: 6/ for test: i915_query results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: kms_psr_stress_test results: parsing output: 9/ for test: kms_force_connector_basic results: parsing output: 10/ for test: kms_addfb_basic results: parsing output: 11/ for test: kms_getfb results: parsing output: 12/ for test: kms_pipe_crc_basic results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: kms_flip results: parsing output: 16/ for test: gem_exec_schedule results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_psr2_sf results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_big_fb results: parsing output: 21/ for test: kms_plane_scaling results: parsing output: 22/ for test: gem_mmap_gtt results: parsing output: 23/ for test: gem_mmap_wc results: parsing output: 24/ for test: gem_exec_params results: parsing output: 25/ for test: gem_exec_balancer results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: kms_addfb_basic results: parsing output: 28/ for test: gem_mmap_offset results: parsing output: 29/ for test: gem_exec_fence results: parsing output: 30/ for test: gem_softpin results: parsing output: 31/ for test: i915_pm_rpm results: parsing output: 32/ for test: gem_exec_suspend results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: kms_cursor_legacy results: parsing output: 35/ for test: gem_exec_reloc results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_atomic_transition results: parsing output: 38/ for test: kms_invalid_mode results: parsing output: 39/ for test: kms_rotation_crc results: parsing output: 40/ for test: kms_ccs results: parsing output: 41/ for test: kms_plane results: parsing output: 42/ for test: kms_flip_scaled_crc results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: kms_ccs results: parsing output: 45/ for test: gem_render_linear_blits results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_psr results: parsing output: 49/ for test: gem_render_copy_redux results: parsing output: 50/ for test: gem_exec_params results: parsing output: 51/ for test: kms_color results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_dsc results: parsing output: 54/ for test: kms_chamelium_hpd results: parsing output: 55/ for test: kms_content_protection results: parsing output: 56/ for test: kms_psr2_sf results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_exec_whisper results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: gem_exec_fence results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_softpin results: parsing output: 66/ for test: kms_universal_plane results: parsing output: 67/ for test: kms_chamelium_frames results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: gem_gtt_cpu_tlb results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: kms_ccs results: parsing output: 74/ for test: gem_ctx_persistence results: parsing output: 75/ for test: gem_mmap_gtt results: parsing output: 76/ for test: gem_exec_reloc results: parsing output: 77/ for test: kms_cursor_legacy results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_ctx_sseu results: parsing output: 81/ for test: gem_mmap_gtt results: parsing output: 82/ for test: gem_pwrite results: parsing output: 83/ for test: kms_pipe_crc_basic results: parsing output: 84/ for test: device_reset results: parsing output: 85/ for test: kms_psr results: parsing output: 86/ for test: perf_pmu results: parsing output: 87/ for test: kms_atomic_transition results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: kms_flip_scaled_crc results: parsing output: 90/ for test: i915_pm_rpm results: parsing output: 91/ for test: kms_chamelium_audio results: parsing output: 92/ for test: sysfs_heartbeat_interval results: parsing output: 93/ for test: kms_psr2_sf results: parsing output: 94/ for test: perf results: parsing output: 95/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 96/ for test: kms_addfb_basic results: parsing output: 97/ for test: gem_render_copy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_atomic_transition results: parsing output: 101/ for test: syncobj_timeline results: parsing output: 102/ for test: kms_flip_scaled_crc results: parsing output: 103/ for test: gem_ctx_isolation results: parsing output: 104/ for test: gen9_exec_parse results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: gem_ctx_persistence results: parsing output: 108/ for test: api_intel_bb results: parsing output: 109/ for test: kms_vblank results: parsing output: 110/ for test: sw_sync results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: gem_exec_params results: parsing output: 114/ for test: drm_fdinfo results: parsing output: 115/ for test: syncobj_timeline results: parsing output: 116/ for test: kms_busy results: parsing output: 117/ for test: gem_softpin results: parsing output: 118/ for test: api_intel_bb results: parsing output: 119/ for test: kms_cursor_edge_walk results: parsing output: 120/ for test: kms_cursor_legacy results: parsing output: 121/ for test: gem_exec_reloc results: parsing output: 122/ for test: gem_lmem_swapping results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: sriov_basic results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_pm_rpm results: parsing output: 129/ for test: syncobj_basic results: parsing output: 130/ for test: perf_pmu Done.