[61.484998] Initializing watchdogs [61.485068] /dev/watchdog0 [61.501279] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [61.505251] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.507186] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.511053] [001/132] (960s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [61.604440] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [61.606747] Starting dynamic subtest: pipe-A-default-mode [62.770564] Dynamic subtest pipe-A-default-mode: SKIP (1.162s) [62.775055] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.163s) [62.926049] [002/132] (959s left) i915_pm_rpm (gem-idle) [65.053064] Starting subtest: gem-idle [71.252830] Subtest gem-idle: SUCCESS (6.204s) [71.595962] [003/132] (950s left) vgem_basic (bad-handle) [71.661232] Starting subtest: bad-handle [71.663292] Subtest bad-handle: SUCCESS (0.000s) [71.711099] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true [71.714218] [004/132] (950s left) kms_addfb_basic (bad-pitch-0) [72.831304] Starting subtest: bad-pitch-0 [72.833787] Subtest bad-pitch-0: SUCCESS (0.000s) [72.975581] [005/132] (949s left) kms_atomic_transition (modeset-transition) [73.047720] Starting subtest: modeset-transition [73.049953] Starting dynamic subtest: 1x-outputs [83.839995] Dynamic subtest 1x-outputs: SUCCESS (10.792s) [83.842756] Subtest modeset-transition: SUCCESS (10.794s) [84.700163] [006/132] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [84.787185] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [84.791495] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [84.881032] [007/132] (937s left) gem_exec_fence (invalid-fence-array) [85.293795] Starting subtest: invalid-fence-array [85.299128] Subtest invalid-fence-array: SUCCESS (0.003s) [86.961778] [008/132] (935s left) gem_busy (extended) [87.158956] Starting subtest: extended [87.161704] Starting dynamic subtest: rcs0 [87.253234] Dynamic subtest rcs0: SUCCESS (0.094s) [87.266603] Starting dynamic subtest: bcs0 [87.294707] Dynamic subtest bcs0: SUCCESS (0.042s) [87.303994] Starting dynamic subtest: vcs0 [88.857654] Dynamic subtest vcs0: SUCCESS (1.560s) [88.867666] Starting dynamic subtest: vcs1 [90.842845] Dynamic subtest vcs1: SUCCESS (1.985s) [90.853907] Starting dynamic subtest: vecs0 [92.826245] Dynamic subtest vecs0: SUCCESS (1.982s) [92.839731] Starting dynamic subtest: ccs0 [92.874126] Dynamic subtest ccs0: SUCCESS (0.048s) [92.876625] Subtest extended: SUCCESS (5.716s) [93.095595] [009/132] (929s left) gem_softpin (noreloc-s3) [93.151445] Starting subtest: noreloc-S3 [113.412874] Subtest noreloc-S3: SUCCESS (5.406s) [113.528095] [010/132] (908s left) kms_chamelium_hpd (hdmi-hpd) [113.908071] Subtest hdmi-hpd: SKIP (0.000s) [114.718307] [011/132] (907s left) kms_big_fb (y-tiled-8bpp-rotate-90) [114.801147] Starting subtest: y-tiled-8bpp-rotate-90 [114.805356] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [114.899363] [012/132] (907s left) perf (invalid-create-userspace-config) [115.032453] Starting subtest: invalid-create-userspace-config [115.034794] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [115.075710] [013/132] (907s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [115.159224] Starting subtest: primary-yf-tiled-reflect-x-180 [115.231327] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.071s) [115.332528] [014/132] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [115.422221] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [122.531341] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.111s) [122.664883] [015/132] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [122.747760] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [122.752039] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [122.841265] [016/132] (899s left) prime_self_import (basic-with_one_bo_two_files) [122.872499] Starting subtest: basic-with_one_bo_two_files [122.898476] Subtest basic-with_one_bo_two_files: SUCCESS (0.026s) [123.005034] [017/132] (899s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [123.092554] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [123.096580] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [123.160313] [018/132] (899s left) gem_wait (await) [123.221134] Starting subtest: await [123.223492] Starting dynamic subtest: all-engines [124.342893] Dynamic subtest all-engines: SUCCESS (1.121s) [124.356381] Starting dynamic subtest: rcs0 [125.412745] Dynamic subtest rcs0: SUCCESS (1.069s) [125.429795] Starting dynamic subtest: bcs0 [126.472829] Dynamic subtest bcs0: SUCCESS (1.059s) [126.489321] Starting dynamic subtest: vcs0 [127.526607] Dynamic subtest vcs0: SUCCESS (1.054s) [127.542999] Starting dynamic subtest: vcs1 [128.587983] Dynamic subtest vcs1: SUCCESS (1.058s) [128.603697] Starting dynamic subtest: vecs0 [129.641050] Dynamic subtest vecs0: SUCCESS (1.052s) [129.657081] Starting dynamic subtest: ccs0 [130.698122] Dynamic subtest ccs0: SUCCESS (1.056s) [130.700875] Subtest await: SUCCESS (7.476s) [130.892826] [019/132] (891s left) kms_flip (2x-plain-flip-fb-recreate) [130.968563] Starting subtest: 2x-plain-flip-fb-recreate [130.975801] Subtest 2x-plain-flip-fb-recreate: SKIP (0.007s) [131.087049] [020/132] (891s left) syncobj_timeline (single-wait-all-available-signaled) [131.151169] Starting subtest: single-wait-all-available-signaled [131.153171] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [131.257105] [021/132] (891s left) kms_flip (wf_vblank-ts-check) [131.339922] Starting subtest: wf_vblank-ts-check [131.342341] Starting dynamic subtest: A-eDP1 [140.291753] Dynamic subtest A-eDP1: SUCCESS (8.953s) [140.303549] Starting dynamic subtest: B-eDP1 [149.210460] Dynamic subtest B-eDP1: SUCCESS (8.916s) [149.220616] Starting dynamic subtest: C-eDP1 [158.127221] Dynamic subtest C-eDP1: SUCCESS (8.914s) [158.136455] Starting dynamic subtest: D-eDP1 [167.064149] Dynamic subtest D-eDP1: SUCCESS (8.936s) [167.070118] Subtest wf_vblank-ts-check: SUCCESS (35.731s) [168.305088] [022/132] (854s left) kms_vblank (ts-continuation-dpms-suspend) [168.378919] Starting subtest: ts-continuation-dpms-suspend [168.380829] Starting dynamic subtest: pipe-A-eDP-1 [184.963320] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.849s) [184.977733] Starting dynamic subtest: pipe-D-eDP-1 [202.995887] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.515s) [202.998528] Subtest ts-continuation-dpms-suspend: SUCCESS (4.367s) [203.803674] [023/132] (819s left) kms_cursor_crc (cursor-rapid-movement-512x170) [204.104743] Starting subtest: cursor-rapid-movement-512x170 [204.109527] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [204.248859] [024/132] (818s left) i915_hangman (engine-engine-hang) [204.301514] Starting subtest: engine-engine-hang [204.303640] Starting dynamic subtest: rcs0 [205.924097] Dynamic subtest rcs0: SUCCESS (1.622s) [205.936719] Starting dynamic subtest: bcs0 [207.910711] Dynamic subtest bcs0: SUCCESS (1.985s) [207.922611] Starting dynamic subtest: vcs0 [209.891574] Dynamic subtest vcs0: SUCCESS (1.979s) [209.903863] Starting dynamic subtest: vcs1 [211.939823] Dynamic subtest vcs1: SUCCESS (2.047s) [211.951854] Starting dynamic subtest: vecs0 [213.924162] Dynamic subtest vecs0: SUCCESS (1.983s) [213.935999] Starting dynamic subtest: ccs0 [215.907807] Dynamic subtest ccs0: SUCCESS (1.982s) [215.910789] Subtest engine-engine-hang: SUCCESS (11.606s) [216.037516] [025/132] (806s left) gem_exec_schedule (preempt-queue-contexts-chain) [216.115049] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [216.405399] [026/132] (806s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [216.492775] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [216.495664] Starting dynamic subtest: pipe-A-eDP-1 [216.905506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s) [216.917055] Starting dynamic subtest: pipe-B-eDP-1 [216.941034] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [216.951835] Starting dynamic subtest: pipe-C-eDP-1 [216.974395] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [216.982693] Starting dynamic subtest: pipe-D-eDP-1 [217.005240] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [217.007444] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.427s) [219.187232] [027/132] (803s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [219.275961] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [224.589219] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.316s) [225.771743] [028/132] (797s left) i915_selftest (live) [227.491722] Starting subtest: live [227.494186] Starting dynamic subtest: sanitycheck [231.098861] Dynamic subtest sanitycheck: SUCCESS (3.606s) [231.108646] Starting dynamic subtest: uncore [234.688727] Dynamic subtest uncore: SUCCESS (3.587s) [234.697586] Starting dynamic subtest: workarounds [253.500187] Dynamic subtest workarounds: FAIL (18.412s) [253.507663] Starting dynamic subtest: gt_engines [257.005148] Dynamic subtest gt_engines: SUCCESS (3.895s) [257.013532] Starting dynamic subtest: gt_timelines [273.030760] Dynamic subtest gt_timelines: SUCCESS (16.022s) [273.039244] Starting dynamic subtest: gt_contexts [276.636526] Dynamic subtest gt_contexts: SUCCESS (3.603s) [276.645536] Starting dynamic subtest: gt_lrc [281.819394] Dynamic subtest gt_lrc: SUCCESS (5.182s) [281.829250] Starting dynamic subtest: gt_mocs [285.671016] Dynamic subtest gt_mocs: SUCCESS (3.849s) [285.680523] Starting dynamic subtest: gt_pm [291.258271] Dynamic subtest gt_pm: SUCCESS (5.586s) [291.267229] Starting dynamic subtest: gt_heartbeat [296.483435] Dynamic subtest gt_heartbeat: SUCCESS (5.223s) [296.497848] Starting dynamic subtest: gt_tlb [306.726617] Dynamic subtest gt_tlb: SUCCESS (10.240s) [306.735619] Starting dynamic subtest: requests [319.498853] Dynamic subtest requests: SUCCESS (12.769s) [319.507690] Starting dynamic subtest: migrate [326.093761] Dynamic subtest migrate: SUCCESS (6.592s) [326.103511] Starting dynamic subtest: active [329.662344] Dynamic subtest active: SUCCESS (3.567s) [329.672249] Starting dynamic subtest: objects [333.713692] Dynamic subtest objects: SUCCESS (4.050s) [333.723641] Starting dynamic subtest: mman [337.903278] Dynamic subtest mman: SUCCESS (4.189s) [337.916991] Starting dynamic subtest: dmabuf [341.539656] Dynamic subtest dmabuf: SUCCESS (3.635s) [341.548640] Starting dynamic subtest: vma [345.132637] Dynamic subtest vma: SUCCESS (3.567s) [345.141942] Starting dynamic subtest: coherency [350.947183] Dynamic subtest coherency: SUCCESS (5.839s) [350.956931] Starting dynamic subtest: gtt [362.961922] Dynamic subtest gtt: SUCCESS (12.014s) [362.971637] Starting dynamic subtest: gem [369.636372] Dynamic subtest gem: SUCCESS (6.673s) [369.646520] Starting dynamic subtest: evict [375.934516] Dynamic subtest evict: SUCCESS (6.296s) [375.943816] Starting dynamic subtest: hugepages [385.535790] Dynamic subtest hugepages: SUCCESS (9.599s) [385.545779] Starting dynamic subtest: gem_contexts [415.396716] Dynamic subtest gem_contexts: SUCCESS (29.859s) [415.405595] Starting dynamic subtest: client [419.020399] Dynamic subtest client: SUCCESS (3.622s) [419.030010] Starting dynamic subtest: gem_migrate [422.598020] Dynamic subtest gem_migrate: SUCCESS (3.575s) [422.608412] Starting dynamic subtest: reset [426.210806] Dynamic subtest reset: SUCCESS (3.610s) [426.221117] Starting dynamic subtest: memory_region [429.733129] Dynamic subtest memory_region: SUCCESS (3.521s) [429.742514] Starting dynamic subtest: hangcheck [443.506103] Dynamic subtest hangcheck: SUCCESS (13.771s) [443.515917] Starting dynamic subtest: execlists [447.086984] Dynamic subtest execlists: SUCCESS (3.580s) [447.097262] Starting dynamic subtest: ring_submission [450.604768] Dynamic subtest ring_submission: SUCCESS (3.516s) [450.614793] Starting dynamic subtest: perf [455.824991] Dynamic subtest perf: SUCCESS (5.218s) [455.834817] Starting dynamic subtest: slpc [468.506722] Dynamic subtest slpc: SUCCESS (12.681s) [468.514606] Starting dynamic subtest: guc [473.355371] Dynamic subtest guc: SUCCESS (4.847s) [473.370294] Starting dynamic subtest: guc_multi_lrc [476.940858] Dynamic subtest guc_multi_lrc: SUCCESS (3.584s) [476.950879] Starting dynamic subtest: guc_hang [481.160991] Dynamic subtest guc_hang: SUCCESS (4.219s) [481.170364] Starting dynamic subtest: late_gt_pm [484.777461] Dynamic subtest late_gt_pm: SUCCESS (3.615s) [484.780300] Subtest live: FAIL (257.261s) [484.809144] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [484.809821] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [484.813442] [029/132] (538s left) kms_plane (pixel-format-yf-tiled-ccs-modifier) [487.196328] Starting subtest: pixel-format-yf-tiled-ccs-modifier [487.201970] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s) [487.300783] [FACT kms_plane (pixel-format-yf-tiled-ccs-modifier)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [487.301882] [FACT kms_plane (pixel-format-yf-tiled-ccs-modifier)] new: kernel.kmod_is_loaded.i915: true [487.306007] [030/132] (535s left) kms_dither (fb-8bpc-vs-panel-8bpc) [487.384846] Starting subtest: fb-8bpc-vs-panel-8bpc [487.387562] Starting dynamic subtest: pipe-A-eDP-1 [488.751330] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.364s) [488.753699] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.365s) [489.563310] [031/132] (533s left) gem_exec_flush (basic-wb-set-default) [489.633914] Starting subtest: basic-wb-set-default [495.096864] Subtest basic-wb-set-default: SUCCESS (5.458s) [495.271288] [032/132] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [495.363405] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [501.905971] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.546s) [502.019008] [033/132] (521s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [502.094744] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [502.099458] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [503.208101] [034/132] (520s left) kms_cursor_crc (cursor-onscreen-32x10) [503.364871] Starting subtest: cursor-onscreen-32x10 [503.415057] Subtest cursor-onscreen-32x10: SKIP (0.045s) [503.667358] [035/132] (519s left) gem_exec_balancer (bonded-false-hang) [503.927273] Starting subtest: bonded-false-hang [503.933051] Subtest bonded-false-hang: SKIP (0.000s) [504.027664] [036/132] (519s left) prime_mmap (test_reprime) [504.076262] Starting subtest: test_reprime [504.078684] Starting dynamic subtest: test_reprime-smem [504.103200] Dynamic subtest test_reprime-smem: SUCCESS (0.030s) [504.105911] Subtest test_reprime: SUCCESS (0.030s) [504.197899] [037/132] (519s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [504.260370] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [504.264868] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [504.326576] [038/132] (519s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [504.694043] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [505.527776] [039/132] (517s left) gen9_exec_parse (unaligned-jump) [505.582757] Subtest unaligned-jump: SKIP (0.000s) [505.644349] [040/132] (517s left) gem_ctx_persistence (legacy-engines-mixed-process) [505.701825] Starting subtest: legacy-engines-mixed-process [505.704323] Starting dynamic subtest: render [506.947330] Dynamic subtest render: SUCCESS (1.245s) [506.957029] Starting dynamic subtest: bsd1 [508.936243] Dynamic subtest bsd1: SUCCESS (1.988s) [508.945540] Starting dynamic subtest: bsd2 [510.963156] Dynamic subtest bsd2: SUCCESS (2.024s) [510.974802] Starting dynamic subtest: blt [512.914833] Dynamic subtest blt: SUCCESS (1.950s) [512.926143] Starting dynamic subtest: vebox [514.973201] Dynamic subtest vebox: SUCCESS (2.056s) [514.975831] Subtest legacy-engines-mixed-process: SUCCESS (9.272s) [515.069009] [041/132] (508s left) prime_vgem (basic-blt) [515.134336] Starting subtest: basic-blt [515.171024] Subtest basic-blt: SUCCESS (0.037s) [515.282609] [042/132] (508s left) gen9_exec_parse (bb-oversize) [515.339757] Subtest bb-oversize: SKIP (0.000s) [515.408065] [043/132] (508s left) perf (mi-rpc) [515.528235] Starting subtest: mi-rpc [515.533404] Subtest mi-rpc: SKIP (0.000s) [515.576066] [044/132] (508s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [515.655769] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [515.658011] Starting dynamic subtest: pipe-A-eDP-1 [515.681257] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [515.690455] Starting dynamic subtest: pipe-B-eDP-1 [515.713750] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [515.722435] Starting dynamic subtest: pipe-C-eDP-1 [515.744628] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [515.752654] Starting dynamic subtest: pipe-D-eDP-1 [515.775484] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [515.779749] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [517.830382] [045/132] (505s left) gem_set_tiling_vs_blt (untiled-to-tiled) [517.887359] Subtest untiled-to-tiled: SKIP (0.000s) [517.965005] [046/132] (505s left) gem_mmap_wc (bad-object) [518.025251] Subtest bad-object: SKIP (0.000s) [518.085875] [047/132] (505s left) syncobj_timeline (multi-wait-all-signaled) [518.147819] Starting subtest: multi-wait-all-signaled [518.150767] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [518.233195] [048/132] (505s left) kms_psr (fbc-psr2-cursor-plane-onoff) [518.308209] Starting subtest: fbc-psr2-cursor-plane-onoff [518.310730] Starting dynamic subtest: eDP-1 [518.315670] Dynamic subtest eDP-1: SKIP (0.000s) [518.320523] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [518.382688] [049/132] (505s left) kms_big_fb (linear-64bpp-rotate-0) [518.465865] Starting subtest: linear-64bpp-rotate-0 [520.145043] Subtest linear-64bpp-rotate-0: SUCCESS (1.679s) [520.289961] [050/132] (503s left) kms_joiner (basic-big-joiner) [520.374797] Starting subtest: basic-big-joiner [520.379922] Subtest basic-big-joiner: SKIP (0.000s) [520.438664] [051/132] (503s left) api_intel_bb (intel-bb-blit-none) [520.496393] Starting subtest: intel-bb-blit-none [524.123222] Subtest intel-bb-blit-none: SUCCESS (3.628s) [524.234619] [052/132] (499s left) kms_big_fb (4-tiled-8bpp-rotate-270) [524.310766] Starting subtest: 4-tiled-8bpp-rotate-270 [524.333282] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s) [524.422483] [053/132] (499s left) syncobj_basic (bad-fd-to-handle) [524.471557] Starting subtest: bad-fd-to-handle [524.474126] Subtest bad-fd-to-handle: SUCCESS (0.000s) [524.570539] [054/132] (499s left) gem_ctx_param (invalid-size-get) [524.617528] Starting subtest: invalid-size-get [524.619864] Subtest invalid-size-get: SUCCESS (0.002s) [524.717400] [055/132] (499s left) gem_exec_fence (syncobj-wait) [525.158553] Starting subtest: syncobj-wait [527.026046] Subtest syncobj-wait: SUCCESS (1.866s) [529.003671] [056/132] (495s left) gem_exec_schedule (preempt-queue-chain) [529.071835] Subtest preempt-queue-chain: SKIP (0.000s) [529.383555] [057/132] (494s left) kms_selftest (drm_dp_mst_helper) [529.418777] Starting subtest: drm_dp_mst_helper [529.424324] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [529.520358] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.095s) [529.531170] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [529.615926] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.092s) [529.626048] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [529.720931] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.107s) [529.723436] Subtest drm_dp_mst_helper: SUCCESS (0.304s) [529.863566] [058/132] (494s left) gem_mmap_gtt (isolation) [529.937273] Subtest isolation: SKIP (0.000s) [529.999107] [059/132] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [530.078774] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [530.083783] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [530.176600] [060/132] (494s left) kms_psr (pr-dpms) [530.257889] Starting subtest: pr-dpms [530.263421] Subtest pr-dpms: SKIP (0.000s) [530.330801] [061/132] (494s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [530.411298] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [530.415731] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [530.507916] [062/132] (493s left) gem_exec_fence (basic-busy-all) [530.571833] Starting subtest: basic-busy-all [530.658020] Subtest basic-busy-all: SUCCESS (0.088s) [533.008107] [063/132] (491s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [533.062791] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [533.065546] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [533.167465] [064/132] (491s left) kms_cdclk (mode-transition) [533.242880] Starting subtest: mode-transition [533.245742] Starting dynamic subtest: pipe-A-eDP-1 [533.539086] Dynamic subtest pipe-A-eDP-1: SKIP (0.292s) [533.548934] Starting dynamic subtest: pipe-B-eDP-1 [533.554574] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [533.564037] Starting dynamic subtest: pipe-C-eDP-1 [533.569623] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [533.579121] Starting dynamic subtest: pipe-D-eDP-1 [533.584728] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [533.590018] Subtest mode-transition: SKIP (0.299s) [534.367697] [065/132] (490s left) kms_flip (bo-too-big-interruptible) [534.448616] Starting subtest: bo-too-big-interruptible [534.451222] Starting dynamic subtest: A-eDP1 [535.717602] Dynamic subtest A-eDP1: SUCCESS (1.268s) [535.727672] Starting dynamic subtest: B-eDP1 [536.953038] Dynamic subtest B-eDP1: SUCCESS (1.235s) [536.964219] Starting dynamic subtest: C-eDP1 [538.189839] Dynamic subtest C-eDP1: SUCCESS (1.234s) [538.205278] Starting dynamic subtest: D-eDP1 [539.436904] Dynamic subtest D-eDP1: SUCCESS (1.244s) [539.443476] Subtest bo-too-big-interruptible: SUCCESS (4.994s) [540.644752] [066/132] (483s left) gem_ctx_isolation (dirty-create) [540.703944] Starting subtest: dirty-create [540.706857] Starting dynamic subtest: rcs0 [540.893620] Dynamic subtest rcs0: SUCCESS (0.189s) [540.903842] Starting dynamic subtest: bcs0 [541.099721] Dynamic subtest bcs0: SUCCESS (0.205s) [541.111004] Starting dynamic subtest: vcs0 [541.315927] Dynamic subtest vcs0: SUCCESS (0.216s) [541.325631] Starting dynamic subtest: vcs1 [543.098485] Dynamic subtest vcs1: SUCCESS (1.781s) [543.108996] Starting dynamic subtest: vecs0 [545.193498] Dynamic subtest vecs0: SUCCESS (2.094s) [545.204066] Starting dynamic subtest: ccs0 [547.184029] Dynamic subtest ccs0: SUCCESS (1.989s) [547.187036] Subtest dirty-create: SUCCESS (6.481s) [547.418964] [067/132] (477s left) kms_pipe_stress (stress-xrgb8888-untiled) [547.506021] Starting subtest: stress-xrgb8888-untiled [553.429877] Subtest stress-xrgb8888-untiled: SUCCESS (5.923s) [553.489666] [068/132] (471s left) gem_close_race (basic-process) [553.553297] Starting subtest: basic-process [553.610262] Subtest basic-process: SUCCESS (0.056s) [553.794751] [069/132] (470s left) kms_feature_discovery (psr1) [553.877779] Starting subtest: psr1 [553.880526] Subtest psr1: SUCCESS (0.000s) [553.950023] [070/132] (470s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [554.029738] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [555.074887] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.045s) [555.197646] [071/132] (469s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [555.272012] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [555.276981] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s) [555.342687] [072/132] (469s left) gem_exec_balancer (sliced) [555.400853] Starting subtest: sliced [555.405714] Subtest sliced: SKIP (0.000s) [555.690485] [073/132] (469s left) perf_pmu (busy-double-start) [555.739188] Starting subtest: busy-double-start [555.742009] Starting dynamic subtest: rcs0 [559.395940] Dynamic subtest rcs0: FAIL (3.576s) [559.406814] Starting dynamic subtest: bcs0 [562.899032] Dynamic subtest bcs0: SUCCESS (3.585s) [562.912141] Starting dynamic subtest: vcs0 [567.425023] Dynamic subtest vcs0: SUCCESS (4.524s) [567.437176] Starting dynamic subtest: vcs1 [571.460928] Dynamic subtest vcs1: SUCCESS (4.034s) [571.473137] Starting dynamic subtest: vecs0 [575.451131] Dynamic subtest vecs0: SUCCESS (3.988s) [575.465031] Starting dynamic subtest: ccs0 [579.024020] Dynamic subtest ccs0: SUCCESS (3.570s) [579.026773] Subtest busy-double-start: FAIL (23.287s) [579.138388] [074/132] (445s left) kms_flip (flip-vs-expired-vblank) [579.219648] Starting subtest: flip-vs-expired-vblank [579.222016] Starting dynamic subtest: A-eDP1 [587.864792] Dynamic subtest A-eDP1: SUCCESS (8.646s) [587.875779] Starting dynamic subtest: B-eDP1 [596.600038] Dynamic subtest B-eDP1: SUCCESS (8.732s) [596.610505] Starting dynamic subtest: C-eDP1 [605.231381] Dynamic subtest C-eDP1: SUCCESS (8.629s) [605.240988] Starting dynamic subtest: D-eDP1 [613.870568] Dynamic subtest D-eDP1: SUCCESS (8.636s) [613.876472] Subtest flip-vs-expired-vblank: SUCCESS (34.656s) [615.039563] [075/132] (409s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [615.133469] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [623.710278] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.583s) [623.815102] [076/132] (401s left) perf (buffer-fill) [623.911703] Starting subtest: buffer-fill [623.914777] Starting dynamic subtest: 0-rcs0 [626.152342] Dynamic subtest 0-rcs0: SUCCESS (2.239s) [626.162226] Starting dynamic subtest: 1-vecs0 [630.545095] Dynamic subtest 1-vecs0: SUCCESS (4.392s) [630.548032] Subtest buffer-fill: SUCCESS (6.634s) [630.588013] [077/132] (394s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [632.129012] Starting subtest: modeset-non-lpsp-stress-no-wait [632.167161] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.040s) [632.825808] [078/132] (392s left) kms_content_protection (atomic-dpms-hdcp14) [632.955613] Starting subtest: atomic-dpms-hdcp14 [632.960751] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [633.081192] [079/132] (392s left) prime_vgem (basic-fence-read) [633.152986] Starting subtest: basic-fence-read [633.178581] Subtest basic-fence-read: SKIP (0.024s) [633.271385] [080/132] (391s left) kms_properties (get_properties-sanity-non-atomic) [633.355910] Starting subtest: get_properties-sanity-non-atomic [633.358303] Subtest get_properties-sanity-non-atomic: SUCCESS (0.003s) [633.441497] [081/132] (391s left) gem_partial_pwrite_pread (write) [633.500687] Subtest write: SKIP (0.000s) [633.578312] [082/132] (391s left) kms_properties (plane-properties-atomic) [633.659193] Starting subtest: plane-properties-atomic [633.661588] Starting dynamic subtest: pipe-A-eDP-1 [634.223146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s) [634.233792] Starting dynamic subtest: pipe-B-eDP-1 [635.508680] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s) [635.518812] Starting dynamic subtest: pipe-C-eDP-1 [636.752618] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.242s) [636.766420] Starting dynamic subtest: pipe-D-eDP-1 [637.987170] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s) [637.990022] Subtest plane-properties-atomic: SUCCESS (4.329s) [638.782633] [083/132] (386s left) syncobj_timeline (invalid-wait-bad-flags) [638.844766] Starting subtest: invalid-wait-bad-flags [638.847562] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [638.947534] [084/132] (386s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [639.021781] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [639.027016] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [639.114947] [085/132] (386s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [639.189044] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [639.194056] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [639.262669] [086/132] (386s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [639.330822] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [639.335830] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [640.423930] [087/132] (385s left) gem_readwrite (write-bad-handle) [640.483226] Subtest write-bad-handle: SKIP (0.000s) [640.536982] [088/132] (384s left) sw_sync (timeline_closed_signaled) [640.576851] Starting subtest: timeline_closed_signaled [640.579527] Subtest timeline_closed_signaled: SUCCESS (0.000s) [640.643859] [089/132] (384s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [643.358013] Starting subtest: dpms-mode-unset-non-lpsp [644.513338] Subtest dpms-mode-unset-non-lpsp: SKIP (1.157s) [644.900346] [090/132] (380s left) kms_addfb_basic (bad-pitch-63) [644.954858] Starting subtest: bad-pitch-63 [644.957588] Subtest bad-pitch-63: SUCCESS (0.000s) [645.082297] [091/132] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [645.159552] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [645.164814] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [645.257179] [092/132] (380s left) gem_userptr_blits (map-fixed-invalidate-busy) [645.319925] Starting subtest: map-fixed-invalidate-busy [645.324991] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [645.436883] [093/132] (380s left) perf_pmu (busy-idle) [645.481581] Starting subtest: busy-idle [645.483737] Starting dynamic subtest: rcs0 [646.168420] Dynamic subtest rcs0: SUCCESS (0.688s) [646.180010] Starting dynamic subtest: bcs0 [646.833407] Dynamic subtest bcs0: SUCCESS (0.662s) [646.846980] Starting dynamic subtest: vcs0 [647.941542] Dynamic subtest vcs0: SUCCESS (1.104s) [647.955248] Starting dynamic subtest: vcs1 [649.925481] Dynamic subtest vcs1: SUCCESS (1.981s) [649.940314] Starting dynamic subtest: vecs0 [651.973389] Dynamic subtest vecs0: SUCCESS (2.045s) [651.986917] Starting dynamic subtest: ccs0 [652.646720] Dynamic subtest ccs0: SUCCESS (0.671s) [652.650004] Subtest busy-idle: SUCCESS (7.168s) [652.752598] [094/132] (373s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [652.835491] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [652.840558] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [652.923804] [095/132] (372s left) kms_psr (psr-sprite-mmap-gtt) [653.009564] Starting subtest: psr-sprite-mmap-gtt [653.011943] Starting dynamic subtest: eDP-1 [654.521909] Dynamic subtest eDP-1: SKIP (1.509s) [654.527829] Subtest psr-sprite-mmap-gtt: SKIP (1.512s) [654.691092] [096/132] (371s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [654.789542] Starting subtest: cursorB-vs-flipA-varying-size [654.794472] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s) [654.934125] [097/132] (370s left) gem_create (create-ext-placement-all) [655.098135] Starting subtest: create-ext-placement-all [655.100728] Subtest create-ext-placement-all: SUCCESS (0.000s) [655.190305] [098/132] (370s left) gem_render_copy (linear-to-vebox-yf-tiled) [655.244112] Starting subtest: linear-to-vebox-yf-tiled [655.249601] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [655.429277] [099/132] (370s left) kms_color (ctm-max) [655.498762] Starting subtest: ctm-max [655.500836] Starting dynamic subtest: pipe-A-eDP-1 [656.217740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s) [656.234526] Starting dynamic subtest: pipe-B-eDP-1 [657.641601] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s) [657.653149] Starting dynamic subtest: pipe-C-eDP-1 [659.012993] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s) [659.023229] Starting dynamic subtest: pipe-D-eDP-1 [660.341699] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s) [660.343860] Subtest ctm-max: SUCCESS (4.842s) [661.148481] [100/132] (364s left) kms_psr (psr2-no-drrs) [661.242034] Starting subtest: psr2-no-drrs [661.244353] Starting dynamic subtest: eDP-1 [662.826731] Dynamic subtest eDP-1: SUCCESS (1.582s) [662.829496] Subtest psr2-no-drrs: SUCCESS (1.583s) [663.622385] [101/132] (362s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [663.704943] Starting subtest: yf-tiled-8bpp-rotate-270 [663.709915] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [663.800356] [102/132] (362s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [663.881696] Starting subtest: async-flip-with-page-flip-events-linear-atomic [664.253743] Starting dynamic subtest: pipe-A-eDP-1 [667.002338] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.748s) [667.365865] Starting dynamic subtest: pipe-B-eDP-1 [670.136679] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.778s) [670.498820] Starting dynamic subtest: pipe-C-eDP-1 [673.262531] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s) [673.622325] Starting dynamic subtest: pipe-D-eDP-1 [676.385671] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s) [676.388606] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.504s) [677.572539] [103/132] (348s left) kms_psr2_su (page_flip-xrgb8888) [677.638809] Subtest page_flip-XRGB8888: SKIP (0.000s) [677.695459] [104/132] (348s left) syncobj_eventfd (invalid-illegal-handle) [677.748928] Starting subtest: invalid-illegal-handle [677.751776] Subtest invalid-illegal-handle: SUCCESS (0.000s) [677.850660] [105/132] (348s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [677.943834] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [677.948902] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [678.037179] [106/132] (348s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [678.116610] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [678.121392] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [678.215561] [107/132] (348s left) gem_mmap_gtt (basic-small-bo-tiledx) [678.276817] Subtest basic-small-bo-tiledX: SKIP (0.000s) [678.335387] [108/132] (348s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [678.412728] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [678.417943] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [678.508154] [109/132] (347s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [678.585336] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [679.663865] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.078s) [679.774892] [110/132] (346s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [679.857593] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [679.862606] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [679.925417] [111/132] (346s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [679.980487] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [680.089456] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [680.166605] [112/132] (346s left) gem_softpin (allocator-basic) [680.232824] Starting subtest: allocator-basic [680.299580] Subtest allocator-basic: SUCCESS (0.067s) [680.418892] [113/132] (346s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [680.502443] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [680.507269] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [680.595422] [114/132] (345s left) gem_flink_basic (bad-open) [680.646569] Starting subtest: bad-open [680.648843] Subtest bad-open: SUCCESS (0.000s) [680.744299] [115/132] (345s left) gem_exec_whisper (basic-fds-priority-all) [680.803539] Starting subtest: basic-fds-priority-all [704.947636] Subtest basic-fds-priority-all: SUCCESS (24.138s) [705.143550] [116/132] (321s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [705.220774] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [705.223233] Starting dynamic subtest: pipe-A [705.242619] Dynamic subtest pipe-A: SKIP (0.017s) [705.252939] Starting dynamic subtest: pipe-B [705.274545] Dynamic subtest pipe-B: SKIP (0.030s) [705.284881] Starting dynamic subtest: pipe-C [705.303738] Dynamic subtest pipe-C: SKIP (0.030s) [705.313836] Starting dynamic subtest: pipe-D [705.334330] Dynamic subtest pipe-D: SKIP (0.031s) [705.338689] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.110s) [705.457575] [117/132] (321s left) gem_ctx_param (basic) [705.514510] Starting subtest: basic [705.516980] Subtest basic: SUCCESS (0.001s) [705.613138] [118/132] (321s left) kms_cursor_edge_walk (64x64-top-bottom) [705.682590] Starting subtest: 64x64-top-bottom [705.685080] Starting dynamic subtest: pipe-A-eDP-1 [709.146929] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s) [709.160692] Starting dynamic subtest: pipe-D-eDP-1 [712.274167] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s) [712.276661] Subtest 64x64-top-bottom: SUCCESS (6.590s) [713.083524] [119/132] (313s left) kms_psr (fbc-psr-primary-blt) [713.163839] Starting subtest: fbc-psr-primary-blt [713.166706] Starting dynamic subtest: eDP-1 [713.171830] Dynamic subtest eDP-1: SKIP (0.000s) [713.177144] Subtest fbc-psr-primary-blt: SKIP (0.001s) [713.238086] [120/132] (313s left) gem_mmap_gtt (cpuset-big-copy-xy) [713.295891] Subtest cpuset-big-copy-XY: SKIP (0.000s) [713.358635] [121/132] (313s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [713.424149] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [713.429032] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [713.600553] [122/132] (313s left) api_intel_allocator (default-alignment) [713.654022] Starting subtest: default-alignment [713.656786] Subtest default-alignment: SUCCESS (0.004s) [713.759335] [123/132] (313s left) kms_lease (lease-get) [713.832236] Starting subtest: lease-get [713.834502] Starting dynamic subtest: pipe-A-eDP-1 [713.836649] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [713.849763] Starting dynamic subtest: pipe-B-eDP-1 [713.852556] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [713.862440] Starting dynamic subtest: pipe-C-eDP-1 [713.864823] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [713.874011] Starting dynamic subtest: pipe-D-eDP-1 [713.876541] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [713.878919] Subtest lease-get: SUCCESS (0.009s) [713.941246] [124/132] (313s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [714.021330] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [720.625943] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.609s) [720.741040] [125/132] (306s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [720.825917] Starting subtest: plane-use-after-nonblocking-unbind [720.828509] Starting dynamic subtest: pipe-A-eDP-1 [720.889289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s) [721.198705] Starting dynamic subtest: pipe-B-eDP-1 [721.994590] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.805s) [722.300015] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.472s) [723.156066] [126/132] (303s left) kms_busy (extended-pageflip-hang-newfb) [723.235148] Starting subtest: extended-pageflip-hang-newfb [723.237501] Starting dynamic subtest: pipe-A [749.806806] Dynamic subtest pipe-A: SUCCESS (26.571s) [749.820017] Starting dynamic subtest: pipe-D [774.750044] Dynamic subtest pipe-D: SUCCESS (24.937s) [774.752984] Subtest extended-pageflip-hang-newfb: SUCCESS (51.516s) [775.605023] [127/132] (251s left) dumb_buffer (create-valid-dumb) [775.658531] Starting subtest: create-valid-dumb [775.660860] Subtest create-valid-dumb: SUCCESS (0.000s) [775.766354] [128/132] (251s left) gem_lmem_swapping (heavy-multi) [775.809157] Subtest heavy-multi: SKIP (0.000s) [775.850881] [129/132] (251s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [775.934645] Starting subtest: psr-1p-primscrn-cur-indfb-move [783.266042] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.334s) [783.391711] [130/132] (243s left) perf_pmu (all-busy-check-all) [783.434809] Starting subtest: all-busy-check-all [784.966688] Subtest all-busy-check-all: SUCCESS (1.530s) [785.055416] [131/132] (242s left) gem_exec_nop (basic-parallel) [785.134871] Starting subtest: basic-parallel [799.942266] Subtest basic-parallel: SUCCESS (14.821s) [800.174705] [132/132] (227s left) gem_exec_flush (basic-batch-kernel-default-uc) [800.225268] Starting subtest: basic-batch-kernel-default-uc [807.640477] Subtest basic-batch-kernel-default-uc: SUCCESS (7.416s) [807.834222] Closing watchdogs results: parsing output: 0/ for test: kms_flip_scaled_crc results: parsing output: 1/ for test: i915_pm_rpm results: parsing output: 2/ for test: vgem_basic results: parsing output: 3/ for test: kms_addfb_basic results: parsing output: 4/ for test: kms_atomic_transition results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_exec_fence results: parsing output: 7/ for test: gem_busy results: parsing output: 8/ for test: gem_softpin results: parsing output: 9/ for test: kms_chamelium_hpd results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: perf results: parsing output: 12/ for test: kms_rotation_crc results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: prime_self_import results: parsing output: 16/ for test: kms_psr2_sf results: parsing output: 17/ for test: gem_wait results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: kms_vblank results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: i915_hangman results: parsing output: 24/ for test: gem_exec_schedule results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: i915_selftest results: parsing output: 28/ for test: kms_plane results: parsing output: 29/ for test: kms_dither results: parsing output: 30/ for test: gem_exec_flush results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: gem_exec_balancer results: parsing output: 35/ for test: prime_mmap results: parsing output: 36/ for test: kms_plane results: parsing output: 37/ for test: kms_chamelium_edid results: parsing output: 38/ for test: gen9_exec_parse results: parsing output: 39/ for test: gem_ctx_persistence results: parsing output: 40/ for test: prime_vgem results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: perf results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: gem_set_tiling_vs_blt results: parsing output: 45/ for test: gem_mmap_wc results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: kms_joiner results: parsing output: 50/ for test: api_intel_bb results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: syncobj_basic results: parsing output: 53/ for test: gem_ctx_param results: parsing output: 54/ for test: gem_exec_fence results: parsing output: 55/ for test: gem_exec_schedule results: parsing output: 56/ for test: kms_selftest results: parsing output: 57/ for test: gem_mmap_gtt results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: gem_exec_fence results: parsing output: 62/ for test: syncobj_wait results: parsing output: 63/ for test: kms_cdclk results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: gem_ctx_isolation results: parsing output: 66/ for test: kms_pipe_stress results: parsing output: 67/ for test: gem_close_race results: parsing output: 68/ for test: kms_feature_discovery results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: kms_plane results: parsing output: 71/ for test: gem_exec_balancer results: parsing output: 72/ for test: perf_pmu results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: perf results: parsing output: 76/ for test: kms_pm_rpm results: parsing output: 77/ for test: kms_content_protection results: parsing output: 78/ for test: prime_vgem results: parsing output: 79/ for test: kms_properties results: parsing output: 80/ for test: gem_partial_pwrite_pread results: parsing output: 81/ for test: kms_properties results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_flip_scaled_crc results: parsing output: 85/ for test: kms_ccs results: parsing output: 86/ for test: gem_readwrite results: parsing output: 87/ for test: sw_sync results: parsing output: 88/ for test: kms_pm_rpm results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_userptr_blits results: parsing output: 92/ for test: perf_pmu results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_psr results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: gem_create results: parsing output: 97/ for test: gem_render_copy results: parsing output: 98/ for test: kms_color results: parsing output: 99/ for test: kms_psr results: parsing output: 100/ for test: kms_big_fb results: parsing output: 101/ for test: kms_async_flips results: parsing output: 102/ for test: kms_psr2_su results: parsing output: 103/ for test: syncobj_eventfd results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: gem_mmap_gtt results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_big_fb results: parsing output: 109/ for test: kms_psr2_sf results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: gem_softpin results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_flink_basic results: parsing output: 114/ for test: gem_exec_whisper results: parsing output: 115/ for test: kms_plane_scaling results: parsing output: 116/ for test: gem_ctx_param results: parsing output: 117/ for test: kms_cursor_edge_walk results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: gem_mmap_gtt results: parsing output: 120/ for test: gem_render_copy results: parsing output: 121/ for test: api_intel_allocator results: parsing output: 122/ for test: kms_lease results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_atomic_transition results: parsing output: 125/ for test: kms_busy results: parsing output: 126/ for test: dumb_buffer results: parsing output: 127/ for test: gem_lmem_swapping results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: perf_pmu results: parsing output: 130/ for test: gem_exec_nop results: parsing output: 131/ for test: gem_exec_flush Done.