[57.456233] Initializing watchdogs [57.456279] /dev/watchdog0 [57.471117] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.475781] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.478216] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.482066] [001/155] (960s left) gem_eio (in-flight-suspend) [57.657678] Starting subtest: in-flight-suspend [100.145599] Subtest in-flight-suspend: SUCCESS (13.534s) [100.275842] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true [100.278991] [002/155] (917s left) kms_cursor_edge_walk (64x64-right-edge) [100.379777] Starting subtest: 64x64-right-edge [100.382133] Starting dynamic subtest: pipe-A-eDP-1 [103.866739] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s) [103.877046] Starting dynamic subtest: pipe-D-eDP-1 [107.069461] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.200s) [107.071761] Subtest 64x64-right-edge: SUCCESS (6.687s) [107.886114] [003/155] (910s left) kms_plane_cursor (primary) [107.981513] Starting subtest: primary [107.985985] Starting dynamic subtest: pipe-A-eDP-1-size-64 [110.578679] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.599s) [110.604468] Starting dynamic subtest: pipe-A-eDP-1-size-128 [113.147227] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s) [113.172963] Starting dynamic subtest: pipe-A-eDP-1-size-256 [115.781964] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.616s) [116.098849] Starting dynamic subtest: pipe-B-eDP-1-size-64 [119.408990] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.320s) [119.434171] Starting dynamic subtest: pipe-B-eDP-1-size-128 [122.010808] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s) [122.034083] Starting dynamic subtest: pipe-B-eDP-1-size-256 [124.612827] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.585s) [124.926252] Starting dynamic subtest: pipe-C-eDP-1-size-64 [127.873245] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.957s) [127.897844] Starting dynamic subtest: pipe-C-eDP-1-size-128 [130.137905] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.248s) [130.167097] Starting dynamic subtest: pipe-C-eDP-1-size-256 [132.426871] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.270s) [133.476020] Starting dynamic subtest: pipe-D-eDP-1-size-64 [135.992384] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.529s) [136.020222] Starting dynamic subtest: pipe-D-eDP-1-size-128 [138.225943] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s) [138.251716] Starting dynamic subtest: pipe-D-eDP-1-size-256 [140.470031] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.225s) [140.787665] Subtest primary: SUCCESS (32.804s) [141.686223] [004/155] (876s left) kms_pm_rpm (modeset-lpsp-stress) [143.427709] Starting subtest: modeset-lpsp-stress [159.170160] Subtest modeset-lpsp-stress: SUCCESS (15.745s) [159.283541] [005/155] (858s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [159.386062] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt [159.390215] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [159.476251] [006/155] (858s left) gem_create (create-ext-placement-sanity-check) [159.644481] Starting subtest: create-ext-placement-sanity-check [159.650345] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s) [159.738692] [007/155] (858s left) kms_psr2_sf (pr-cursor-plane-update-sf) [159.835998] Starting subtest: pr-cursor-plane-update-sf [159.840370] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [159.919303] [008/155] (858s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt) [160.020892] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt [160.025161] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [160.115119] [009/155] (858s left) gem_mmap_gtt (basic-small-bo-tiledx) [160.169306] Subtest basic-small-bo-tiledX: SKIP (0.000s) [160.231481] [010/155] (858s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [160.354218] Starting subtest: verify-pxp-key-change-after-suspend-resume [168.322496] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.971s) [168.450010] [011/155] (849s left) kms_frontbuffer_tracking (pipe-fbc-rte) [168.547611] Starting subtest: pipe-fbc-rte [168.555784] Starting dynamic subtest: pipe-B-eDP-1 [173.989893] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.447s) [173.997322] Subtest pipe-fbc-rte: SUCCESS (5.449s) [176.255873] [012/155] (842s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [176.353343] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [176.355659] Starting dynamic subtest: pipe-A [176.375813] Dynamic subtest pipe-A: SKIP (0.019s) [176.385571] Starting dynamic subtest: pipe-B [176.408713] Dynamic subtest pipe-B: SKIP (0.033s) [176.417977] Starting dynamic subtest: pipe-C [176.443186] Dynamic subtest pipe-C: SKIP (0.033s) [176.452221] Starting dynamic subtest: pipe-D [176.475694] Dynamic subtest pipe-D: SKIP (0.033s) [176.480040] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.120s) [176.577872] [013/155] (841s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [176.692013] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [176.696342] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [176.796067] [014/155] (841s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff) [176.910426] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff [176.914558] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [177.035173] [015/155] (841s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [177.141653] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [177.145710] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [177.240824] [016/155] (841s left) gem_caching (writes) [177.301234] Subtest writes: SKIP (0.000s) [177.367653] [017/155] (841s left) perf (polling) [177.491501] Starting subtest: polling [177.493311] Starting dynamic subtest: 0-rcs0 [187.519121] Dynamic subtest 0-rcs0: SUCCESS (10.027s) [187.529425] Starting dynamic subtest: 1-vecs0 [197.537988] Dynamic subtest 1-vecs0: SUCCESS (10.017s) [197.540271] Subtest polling: SUCCESS (20.047s) [197.588969] [018/155] (821s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [197.692267] Starting subtest: invalidate-primary-flip-overlay [208.404032] Subtest invalidate-primary-flip-overlay: SUCCESS (10.713s) [208.518047] [019/155] (810s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [208.575332] Starting subtest: etime-single-wait-available-unsubmitted [208.682472] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s) [208.772798] [020/155] (809s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc) [208.870173] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc [208.874681] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [208.965175] [021/155] (809s left) gem_ctx_shared (single-timeline) [209.030377] Starting subtest: single-timeline [209.048028] Subtest single-timeline: SUCCESS (0.015s) [209.274618] [022/155] (809s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [209.375122] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [216.737480] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.367s) [216.885020] [023/155] (802s left) gem_mmap_offset (ptrace) [216.942247] Starting subtest: ptrace [216.944551] Starting dynamic subtest: smem0-wb [216.957238] Dynamic subtest smem0-wb: SUCCESS (0.015s) [216.968424] Starting dynamic subtest: smem0-wc [216.977429] Dynamic subtest smem0-wc: SUCCESS (0.019s) [216.989548] Starting dynamic subtest: smem0-uc [216.996635] Dynamic subtest smem0-uc: SUCCESS (0.018s) [216.998901] Subtest ptrace: SUCCESS (0.058s) [217.083669] [024/155] (801s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [217.200605] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [217.204524] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [217.284147] [025/155] (801s left) kms_content_protection (dp-mst-lic-type-0) [217.426595] Starting subtest: dp-mst-lic-type-0 [217.431075] Subtest dp-mst-lic-type-0: SKIP (0.000s) [217.557643] [026/155] (801s left) gem_eio (in-flight-external) [217.774716] Starting subtest: in-flight-external [219.303852] Subtest in-flight-external: SUCCESS (1.528s) [219.445994] [027/155] (799s left) gem_exec_reloc (basic-scanout) [219.508152] Subtest basic-scanout: SKIP (0.000s) [219.591743] [028/155] (799s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [219.690025] Starting subtest: psr-rgb565-draw-render [226.850217] Subtest psr-rgb565-draw-render: SUCCESS (7.166s) [226.976909] [029/155] (792s left) kms_cursor_crc (cursor-random-max-size) [227.305615] Starting subtest: cursor-random-max-size [227.312170] Subtest cursor-random-max-size: SKIP (0.000s) [227.429502] [030/155] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [227.529192] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [234.871393] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.348s) [235.013405] [031/155] (784s left) i915_hangman (engine-engine-hang) [235.083834] Starting subtest: engine-engine-hang [235.085748] Starting dynamic subtest: rcs0 [236.211285] Dynamic subtest rcs0: SUCCESS (1.127s) [236.222766] Starting dynamic subtest: bcs0 [238.196392] Dynamic subtest bcs0: SUCCESS (1.982s) [238.209957] Starting dynamic subtest: vcs0 [240.180662] Dynamic subtest vcs0: SUCCESS (1.981s) [240.193296] Starting dynamic subtest: vcs1 [242.228852] Dynamic subtest vcs1: SUCCESS (2.045s) [242.240927] Starting dynamic subtest: vecs0 [244.212850] Dynamic subtest vecs0: SUCCESS (1.982s) [244.224988] Starting dynamic subtest: ccs0 [246.197232] Dynamic subtest ccs0: SUCCESS (1.982s) [246.200255] Subtest engine-engine-hang: SUCCESS (11.115s) [246.292181] [032/155] (772s left) gem_ringfill (engines-basic) [252.251658] Starting subtest: engines-basic [252.254216] Starting dynamic subtest: rcs0 [252.310350] Dynamic subtest rcs0: SUCCESS (0.059s) [252.322644] Starting dynamic subtest: bcs0 [252.352985] Dynamic subtest bcs0: SUCCESS (0.041s) [252.364201] Starting dynamic subtest: vcs0 [252.396830] Dynamic subtest vcs0: SUCCESS (0.042s) [252.408021] Starting dynamic subtest: vcs1 [252.440607] Dynamic subtest vcs1: SUCCESS (0.042s) [252.451237] Starting dynamic subtest: vecs0 [252.483874] Dynamic subtest vecs0: SUCCESS (0.041s) [252.494692] Starting dynamic subtest: ccs0 [252.528903] Dynamic subtest ccs0: SUCCESS (0.043s) [252.531507] Subtest engines-basic: SUCCESS (0.280s) [252.608534] [033/155] (766s left) syncobj_basic (bad-destroy) [252.666589] Starting subtest: bad-destroy [252.669104] Subtest bad-destroy: SUCCESS (0.000s) [252.774298] [034/155] (766s left) perf (oa-formats) [252.872387] Starting subtest: oa-formats [252.874823] Starting dynamic subtest: 0-rcs0 [252.885117] Dynamic subtest 0-rcs0: SUCCESS (0.012s) [252.895957] Starting dynamic subtest: 1-vcs1 [252.907247] Dynamic subtest 1-vcs1: SUCCESS (0.022s) [252.909610] Subtest oa-formats: SUCCESS (0.036s) [252.990875] [035/155] (766s left) i915_pm_rc6_residency (rc6-accuracy) [253.046914] Starting subtest: rc6-accuracy [253.049133] Starting dynamic subtest: gt0 [256.219108] Dynamic subtest gt0: SUCCESS (3.169s) [256.229172] Starting dynamic subtest: gt1 [259.390123] Dynamic subtest gt1: SUCCESS (3.168s) [259.392635] Subtest rc6-accuracy: SUCCESS (6.343s) [259.482481] [036/155] (760s left) kms_vblank (ts-continuation-dpms-rpm) [259.581721] Starting subtest: ts-continuation-dpms-rpm [259.583619] Starting dynamic subtest: pipe-A-eDP-1 [262.129569] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.548s) [262.145651] Starting dynamic subtest: pipe-D-eDP-1 [264.390516] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.258s) [264.392643] Subtest ts-continuation-dpms-rpm: SUCCESS (4.810s) [265.266447] [037/155] (754s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [265.359215] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [265.361490] Starting dynamic subtest: pipe-A-eDP-1 [265.384055] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [265.397149] Starting dynamic subtest: pipe-B-eDP-1 [265.418616] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [265.427488] Starting dynamic subtest: pipe-C-eDP-1 [265.448789] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [265.457804] Starting dynamic subtest: pipe-D-eDP-1 [265.479686] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [265.483635] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s) [267.635651] [038/155] (751s left) kms_getfb (getfb-handle-closed) [267.733593] Starting subtest: getfb-handle-closed [267.735877] Subtest getfb-handle-closed: SUCCESS (0.000s) [267.842657] [039/155] (751s left) gem_exec_gttfill (basic) [267.900966] Starting subtest: basic [270.571520] Subtest basic: SUCCESS (2.670s) [270.765804] [040/155] (748s left) gen9_exec_parse (batch-invalid-length) [270.876334] Subtest batch-invalid-length: SKIP (0.000s) [270.935369] [041/155] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [271.038657] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [271.042722] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [271.135786] [042/155] (748s left) prime_mmap (test_reprime) [271.191820] Starting subtest: test_reprime [271.193744] Starting dynamic subtest: test_reprime-smem [271.222722] Dynamic subtest test_reprime-smem: SUCCESS (0.033s) [271.225181] Subtest test_reprime: SUCCESS (0.034s) [271.346081] [043/155] (748s left) gem_ctx_shared (detached-shared-gtt) [271.408240] Starting subtest: detached-shared-gtt [273.559843] Subtest detached-shared-gtt: SUCCESS (2.151s) [274.011023] [044/155] (745s left) gem_exec_balancer (smoke) [274.068216] Starting subtest: smoke [296.707568] Subtest smoke: SUCCESS (22.637s) [297.597686] [045/155] (722s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc) [297.700848] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc [297.705130] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [297.812780] [046/155] (722s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt) [297.905061] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt [297.909102] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [298.012955] [047/155] (721s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [298.110174] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [298.114620] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [298.221921] [048/155] (721s left) gem_exec_schedule (preempt-hang) [298.410336] Starting subtest: preempt-hang [298.412929] Starting dynamic subtest: rcs0 [298.645598] Dynamic subtest rcs0: SUCCESS (0.237s) [298.657989] Starting dynamic subtest: bcs0 [298.879241] Dynamic subtest bcs0: SUCCESS (0.233s) [298.889763] Starting dynamic subtest: vcs0 [299.108390] Dynamic subtest vcs0: SUCCESS (0.229s) [299.119426] Starting dynamic subtest: vcs1 [299.341077] Dynamic subtest vcs1: SUCCESS (0.231s) [299.354067] Starting dynamic subtest: vecs0 [299.578622] Dynamic subtest vecs0: SUCCESS (0.233s) [299.591464] Starting dynamic subtest: ccs0 [299.809909] Dynamic subtest ccs0: SUCCESS (0.232s) [299.812107] Subtest preempt-hang: SUCCESS (1.402s) [300.342478] [049/155] (719s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [300.461756] Starting subtest: modeset-atomic-cursor-hotspot [300.466373] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [300.610449] [050/155] (719s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [300.670071] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [300.739004] [051/155] (719s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [300.861961] Starting subtest: cursorA-vs-flipA-atomic-transitions [312.056251] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.194s) [312.862819] [052/155] (707s left) gem_userptr_blits (readonly-pwrite-unsync) [312.945998] Subtest readonly-pwrite-unsync: SKIP (0.000s) [313.071137] [053/155] (707s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [313.171027] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [313.175166] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [313.281506] [054/155] (706s left) gem_render_copy (y-tiled-ccs-to-linear) [313.340900] Starting subtest: y-tiled-ccs-to-linear [313.345393] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [313.526453] [055/155] (706s left) kms_cursor_crc (cursor-onscreen-256x256) [313.761104] Starting subtest: cursor-onscreen-256x256 [313.765934] Starting dynamic subtest: pipe-A-eDP-1 [315.891782] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.125s) [315.924730] Starting dynamic subtest: pipe-D-eDP-1 [318.672332] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.754s) [318.675061] Subtest cursor-onscreen-256x256: SUCCESS (4.908s) [319.545340] [056/155] (700s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [319.593236] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [319.698879] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s) [319.800967] [057/155] (700s left) kms_psr (psr-cursor-mmap-cpu) [319.902579] Starting subtest: psr-cursor-mmap-cpu [319.904865] Starting dynamic subtest: eDP-1 [321.638603] Dynamic subtest eDP-1: SUCCESS (1.737s) [321.640737] Subtest psr-cursor-mmap-cpu: SUCCESS (1.738s) [322.509700] [058/155] (697s left) kms_big_fb (y-tiled-8bpp-rotate-180) [322.617318] Starting subtest: y-tiled-8bpp-rotate-180 [322.621802] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [322.711924] [059/155] (697s left) gem_ctx_isolation (dirty-create) [322.780049] Starting subtest: dirty-create [322.782425] Starting dynamic subtest: rcs0 [322.960356] Dynamic subtest rcs0: SUCCESS (0.180s) [322.973197] Starting dynamic subtest: bcs0 [323.162323] Dynamic subtest bcs0: SUCCESS (0.201s) [323.174134] Starting dynamic subtest: vcs0 [323.378283] Dynamic subtest vcs0: SUCCESS (0.215s) [323.390667] Starting dynamic subtest: vcs1 [325.486186] Dynamic subtest vcs1: SUCCESS (2.106s) [325.497309] Starting dynamic subtest: vecs0 [327.456184] Dynamic subtest vecs0: SUCCESS (1.969s) [327.468327] Starting dynamic subtest: ccs0 [329.473396] Dynamic subtest ccs0: SUCCESS (2.016s) [329.475917] Subtest dirty-create: SUCCESS (6.694s) [329.718589] [060/155] (690s left) kms_plane_multiple (2x-tiling-x) [329.817379] Starting subtest: 2x-tiling-x [329.821564] Subtest 2x-tiling-x: SKIP (0.000s) [329.906217] [061/155] (690s left) gem_exec_capture (userptr) [329.975560] Starting subtest: userptr [330.806224] Subtest userptr: SUCCESS (0.830s) [330.907412] [062/155] (689s left) kms_pm_rpm (pm-caching) [332.439864] Starting subtest: pm-caching [332.445166] Subtest pm-caching: SKIP (0.000s) [333.156765] [063/155] (687s left) perf_pmu (invalid-init) [333.191858] Starting subtest: invalid-init [333.194074] Subtest invalid-init: SUCCESS (0.000s) [333.301785] [064/155] (687s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-onoff) [333.401963] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-onoff [333.406290] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [333.498394] [065/155] (687s left) kms_psr (fbc-psr-sprite-mmap-cpu) [333.592404] Starting subtest: fbc-psr-sprite-mmap-cpu [333.594653] Starting dynamic subtest: eDP-1 [333.598701] Dynamic subtest eDP-1: SKIP (0.000s) [333.602716] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s) [333.665146] [066/155] (687s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render) [333.771327] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render [333.775696] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [333.859398] [067/155] (686s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [333.946313] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [333.948702] Starting dynamic subtest: pipe-A-eDP-1 [333.971974] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [333.984759] Starting dynamic subtest: pipe-B-eDP-1 [334.006617] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [334.016031] Starting dynamic subtest: pipe-C-eDP-1 [334.036919] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [334.046692] Starting dynamic subtest: pipe-D-eDP-1 [334.068500] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [334.072222] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s) [336.212204] [068/155] (684s left) kms_flip (flip-vs-suspend-interruptible) [336.309521] Starting subtest: flip-vs-suspend-interruptible [336.311823] Starting dynamic subtest: A-eDP1 [482.028291] Dynamic subtest A-eDP1: SUCCESS (11.275s) [482.031139] Subtest flip-vs-suspend-interruptible: SUCCESS (11.278s) [483.168497] [069/155] (538s left) gem_spin_batch (engines) [483.236145] Starting subtest: engines [483.238900] Starting dynamic subtest: rcs0 [486.476910] Dynamic subtest rcs0: SUCCESS (3.231s) [486.488757] Starting dynamic subtest: bcs0 [489.716174] Dynamic subtest bcs0: SUCCESS (3.232s) [489.729181] Starting dynamic subtest: vcs0 [492.952574] Dynamic subtest vcs0: SUCCESS (3.232s) [492.967168] Starting dynamic subtest: vcs1 [496.188880] Dynamic subtest vcs1: SUCCESS (3.230s) [496.200526] Starting dynamic subtest: vecs0 [499.426036] Dynamic subtest vecs0: SUCCESS (3.232s) [499.439940] Starting dynamic subtest: ccs0 [502.664992] Dynamic subtest ccs0: SUCCESS (3.235s) [502.668012] Subtest engines: SUCCESS (19.410s) [502.884495] [070/155] (519s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [502.986962] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc [502.991894] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [503.066629] [071/155] (518s left) gem_fence_thrash (bo-write-verify-x) [503.103962] Starting subtest: bo-write-verify-x [503.117762] Subtest bo-write-verify-x: SKIP (0.013s) [503.179986] [072/155] (518s left) kms_chamelium_color (ctm-blue-to-red) [503.274501] Subtest ctm-blue-to-red: SKIP (0.000s) [503.323313] [073/155] (518s left) api_intel_bb (object-reloc-purge-cache) [503.383956] Starting subtest: object-reloc-purge-cache [503.389406] Subtest object-reloc-purge-cache: SKIP (0.002s) [503.491592] [074/155] (518s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy) [503.582547] Starting subtest: fbchdr-modesetfrombusy [503.587157] Subtest fbchdr-modesetfrombusy: SKIP (0.000s) [503.682474] [075/155] (518s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt) [503.782839] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt [503.787776] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [503.891022] [076/155] (518s left) kms_plane (pixel-format-y-tiled-ccs-modifier) [503.984726] Starting subtest: pixel-format-y-tiled-ccs-modifier [503.989163] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s) [504.057517] [077/155] (518s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [504.156784] Starting subtest: ccs-on-another-bo-y-tiled-ccs [504.158886] Starting dynamic subtest: pipe-A-eDP-1 [504.180954] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [504.191615] Starting dynamic subtest: pipe-B-eDP-1 [504.214882] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [504.224965] Starting dynamic subtest: pipe-C-eDP-1 [504.246782] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [504.256245] Starting dynamic subtest: pipe-D-eDP-1 [504.279682] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [504.283983] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [506.452815] [078/155] (515s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move) [506.552501] Starting subtest: hdr-1p-primscrn-cur-indfb-move [506.557719] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [506.647443] [079/155] (515s left) kms_lease (lease-again) [506.735113] Starting subtest: lease-again [506.737916] Starting dynamic subtest: pipe-A-eDP-1 [506.740634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s) [506.751564] Starting dynamic subtest: pipe-B-eDP-1 [506.753721] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [506.763688] Starting dynamic subtest: pipe-C-eDP-1 [506.765956] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [506.775946] Starting dynamic subtest: pipe-D-eDP-1 [506.778162] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [506.780596] Subtest lease-again: SUCCESS (0.015s) [506.853710] [080/155] (515s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [506.949489] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [506.954162] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [507.022354] [081/155] (515s left) kms_lease (atomic-implicit-crtc) [507.108623] Starting subtest: atomic-implicit-crtc [507.111136] Starting dynamic subtest: pipe-A-eDP-1 [507.123492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [507.135934] Starting dynamic subtest: pipe-B-eDP-1 [507.148441] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [507.158651] Starting dynamic subtest: pipe-C-eDP-1 [507.171628] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s) [507.181915] Starting dynamic subtest: pipe-D-eDP-1 [507.194855] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [507.197406] Subtest atomic-implicit-crtc: SUCCESS (0.037s) [507.264677] [082/155] (515s left) gem_exec_flush (basic-wb-pro-default) [507.321699] Starting subtest: basic-wb-pro-default [512.780965] Subtest basic-wb-pro-default: SUCCESS (5.457s) [512.974907] [083/155] (509s left) kms_vrr (seamless-rr-switch-drrs) [513.081017] Starting subtest: seamless-rr-switch-drrs [513.089138] Subtest seamless-rr-switch-drrs: SKIP (0.000s) [513.153015] [084/155] (509s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render) [513.259687] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render [513.264830] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [513.356953] [085/155] (509s left) gem_exec_reloc (basic-cpu) [513.419923] Subtest basic-cpu: SKIP (0.000s) [513.486647] [086/155] (509s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt) [513.588687] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt [513.593812] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [513.689009] [087/155] (508s left) kms_async_flips (crc-atomic) [513.782022] Starting subtest: crc-atomic [514.161893] Starting dynamic subtest: pipe-A-eDP-1 [517.072637] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.913s) [517.453591] Starting dynamic subtest: pipe-B-eDP-1 [520.391401] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.947s) [520.778076] Starting dynamic subtest: pipe-C-eDP-1 [523.708073] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.940s) [524.076065] Starting dynamic subtest: pipe-D-eDP-1 [526.937022] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.875s) [526.939940] Subtest crc-atomic: SUCCESS (13.161s) [528.120244] [088/155] (494s left) syncobj_wait (multi-wait-all-submitted) [528.184117] Starting subtest: multi-wait-all-submitted [528.283945] Subtest multi-wait-all-submitted: SUCCESS (0.101s) [528.364239] [089/155] (494s left) kms_psr (psr2-cursor-mmap-gtt) [528.458136] Starting subtest: psr2-cursor-mmap-gtt [528.460803] Starting dynamic subtest: eDP-1 [530.181565] Dynamic subtest eDP-1: SUCCESS (1.722s) [530.183993] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.723s) [531.068826] [090/155] (491s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [531.166976] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [531.172050] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [531.251515] [091/155] (491s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render) [531.347701] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render [531.352763] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [531.445778] [092/155] (491s left) kms_psr (fbc-pr-primary-render) [531.534081] Starting subtest: fbc-pr-primary-render [531.539976] Subtest fbc-pr-primary-render: SKIP (0.000s) [531.609713] [093/155] (491s left) kms_flip (2x-plain-flip-interruptible) [531.698722] Starting subtest: 2x-plain-flip-interruptible [531.711027] Subtest 2x-plain-flip-interruptible: SKIP (0.011s) [531.785900] [094/155] (491s left) kms_chamelium_frames (hdmi-crc-single) [532.167626] Subtest hdmi-crc-single: SKIP (0.000s) [532.971936] [095/155] (490s left) kms_atomic (crtc-invalid-params-fence) [533.074433] Starting subtest: crtc-invalid-params-fence [533.077009] Starting dynamic subtest: pipe-A-eDP-1 [533.496448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.422s) [533.499066] Subtest crtc-invalid-params-fence: SUCCESS (0.424s) [534.324831] [096/155] (488s left) gem_exec_params (secure-non-master) [534.396701] Starting subtest: secure-non-master [534.402135] Subtest secure-non-master: SKIP (0.000s) [534.509394] [097/155] (488s left) kms_invalid_mode (bad-hsync-end) [534.606152] Starting subtest: bad-hsync-end [534.608870] Starting dynamic subtest: pipe-A-eDP-1 [534.898280] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [534.909298] Starting dynamic subtest: pipe-B-eDP-1 [534.911729] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [534.922620] Starting dynamic subtest: pipe-C-eDP-1 [534.925079] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [534.936978] Starting dynamic subtest: pipe-D-eDP-1 [534.939628] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [534.942228] Subtest bad-hsync-end: SUCCESS (0.298s) [535.751171] [098/155] (487s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [535.842915] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [535.847930] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [535.945860] [099/155] (487s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc) [536.045613] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc [536.050448] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [536.146512] [100/155] (487s left) gem_userptr_blits (coherency-sync) [536.218906] Starting subtest: coherency-sync [536.403580] Subtest coherency-sync: SKIP (0.148s) [536.507623] [101/155] (486s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [536.622963] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [536.683705] [102/155] (486s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [536.776448] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [536.781518] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [536.874536] [103/155] (486s left) gem_userptr_blits (process-exit-busy) [536.943526] Starting subtest: process-exit-busy [536.954438] Subtest process-exit-busy: SUCCESS (0.013s) [537.074531] [104/155] (486s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [537.184552] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [537.194997] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s) [537.282438] [105/155] (486s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff) [537.380858] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff [537.384949] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [537.479857] [106/155] (486s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [537.587936] Starting subtest: fbc-psr2-cursor-plane-update-sf [537.590116] Starting dynamic subtest: pipe-A-eDP-1 [537.674630] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s) [537.686173] Starting dynamic subtest: pipe-B-eDP-1 [538.821989] Dynamic subtest pipe-B-eDP-1: SKIP (1.141s) [538.827769] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.235s) [540.007039] [107/155] (483s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [540.125282] Starting subtest: short-flip-before-cursor-toggle [541.074958] Subtest short-flip-before-cursor-toggle: SUCCESS (0.947s) [541.936881] [108/155] (481s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [542.048133] Starting subtest: cursorA-vs-flipA-legacy [553.177996] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.126s) [554.075473] [109/155] (469s left) kms_atomic_transition (plane-all-transition) [554.175038] Starting subtest: plane-all-transition [554.177701] Starting dynamic subtest: pipe-A-eDP-1 [556.668506] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [556.976772] Starting dynamic subtest: pipe-B-eDP-1 [560.192718] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.225s) [560.513923] Subtest plane-all-transition: SUCCESS (6.340s) [561.320153] [110/155] (462s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [561.420778] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [561.425753] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [561.524587] [111/155] (462s left) gem_exec_whisper (basic-queues-priority) [561.589348] Starting subtest: basic-queues-priority [584.770253] Subtest basic-queues-priority: SUCCESS (23.178s) [584.958306] [112/155] (438s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [585.030333] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [585.033131] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [585.122008] [113/155] (438s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [585.226994] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [585.231981] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [585.323262] [114/155] (438s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [585.426970] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [585.431954] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [585.530070] [115/155] (438s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [585.588443] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [585.652467] [116/155] (438s left) gem_exec_store (dword) [585.716175] Starting subtest: dword [585.718604] Starting dynamic subtest: rcs0 [585.779909] Dynamic subtest rcs0: SUCCESS (0.066s) [585.795274] Starting dynamic subtest: bcs0 [585.824361] Dynamic subtest bcs0: SUCCESS (0.041s) [585.835812] Starting dynamic subtest: vcs0 [585.867700] Dynamic subtest vcs0: SUCCESS (0.041s) [585.879176] Starting dynamic subtest: vcs1 [585.911443] Dynamic subtest vcs1: SUCCESS (0.042s) [585.924595] Starting dynamic subtest: vecs0 [585.954614] Dynamic subtest vecs0: SUCCESS (0.041s) [585.967817] Starting dynamic subtest: ccs0 [585.998138] Dynamic subtest ccs0: SUCCESS (0.042s) [586.000835] Subtest dword: SUCCESS (0.286s) [586.196539] [117/155] (437s left) kms_addfb_basic (addfb25-modifier-no-flag) [586.291835] Starting subtest: addfb25-modifier-no-flag [586.294419] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [586.401061] [118/155] (437s left) kms_big_fb (linear-16bpp-rotate-0) [586.499365] Starting subtest: linear-16bpp-rotate-0 [587.967842] Subtest linear-16bpp-rotate-0: SUCCESS (1.468s) [588.090581] [119/155] (436s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [588.189461] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [588.193812] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [588.273896] [120/155] (435s left) kms_feature_discovery (chamelium) [588.369894] Starting subtest: chamelium [588.374871] Subtest chamelium: SKIP (0.000s) [588.452830] [121/155] (435s left) gem_exec_balancer (individual) [588.502640] Starting subtest: individual [590.674026] Subtest individual: SUCCESS (2.170s) [590.984904] [122/155] (433s left) kms_big_fb (4-tiled-8bpp-rotate-0) [591.094135] Starting subtest: 4-tiled-8bpp-rotate-0 [592.341143] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.248s) [592.454333] [123/155] (431s left) gem_userptr_blits (stress-purge) [592.510804] Starting subtest: stress-purge [597.896258] Subtest stress-purge: SUCCESS (5.388s) [598.035680] [124/155] (426s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip) [598.181667] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip [598.186334] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [598.293501] [125/155] (426s left) i915_suspend (forcewake) [598.355143] Starting subtest: forcewake [630.003606] Subtest forcewake: SUCCESS (2.251s) [630.084744] [126/155] (394s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [630.197627] Starting subtest: fbcpsr-rgb101010-draw-pwrite [635.267623] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.070s) [635.371842] [127/155] (389s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [635.466493] Starting subtest: plane-lut1d-pre-ctm3x4 [635.647451] Starting dynamic subtest: pipe-A-plane-0 [635.848770] Dynamic subtest pipe-A-plane-0: SUCCESS (0.201s) [635.860041] Starting dynamic subtest: pipe-A-plane-1 [636.039343] Dynamic subtest pipe-A-plane-1: SUCCESS (0.187s) [636.050656] Starting dynamic subtest: pipe-A-plane-2 [636.224842] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s) [637.462654] Starting dynamic subtest: pipe-B-plane-0 [637.631729] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [637.642888] Starting dynamic subtest: pipe-B-plane-1 [637.821041] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [637.833827] Starting dynamic subtest: pipe-B-plane-2 [637.987950] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [639.208688] Starting dynamic subtest: pipe-C-plane-0 [639.353938] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [639.365816] Starting dynamic subtest: pipe-C-plane-1 [639.509876] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [639.521825] Starting dynamic subtest: pipe-C-plane-2 [639.665772] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [640.844949] Starting dynamic subtest: pipe-D-plane-0 [640.980303] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [640.991752] Starting dynamic subtest: pipe-D-plane-1 [641.146955] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [641.158163] Starting dynamic subtest: pipe-D-plane-2 [641.291801] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [641.575456] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.106s) [642.414121] [128/155] (382s left) syncobj_timeline (wait-all-interrupted) [642.475474] Starting subtest: wait-all-interrupted [642.580816] Subtest wait-all-interrupted: SUCCESS (0.104s) [642.664824] [129/155] (381s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [642.760761] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [642.763348] Starting dynamic subtest: pipe-A [642.824074] Dynamic subtest pipe-A: SUCCESS (0.066s) [642.835721] Starting dynamic subtest: pipe-B [643.948667] Dynamic subtest pipe-B: SUCCESS (1.123s) [643.961201] Starting dynamic subtest: pipe-C [645.058449] Dynamic subtest pipe-C: SUCCESS (1.108s) [645.071907] Starting dynamic subtest: pipe-D [646.185561] Dynamic subtest pipe-D: SUCCESS (1.125s) [646.188206] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.426s) [647.359482] [130/155] (377s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [647.458860] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [652.325046] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.873s) [653.469360] [131/155] (371s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render) [653.563033] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render [653.567766] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [653.656605] [132/155] (371s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [653.750926] Starting subtest: yf-tiled-32bpp-rotate-0 [653.756304] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [653.885783] [133/155] (370s left) i915_drm_fdinfo (memory-info-resident) [653.930042] Starting subtest: memory-info-resident [653.932669] Starting dynamic subtest: smem0 [656.817516] Dynamic subtest smem0: SUCCESS (2.886s) [656.819801] Subtest memory-info-resident: SUCCESS (2.887s) [656.895608] [134/155] (367s left) kms_chamelium_hpd (vga-hpd-fast) [657.287116] Subtest vga-hpd-fast: SKIP (0.000s) [658.076448] [135/155] (366s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [658.182519] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt [658.186953] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [658.276675] [136/155] (366s left) gem_userptr_blits (sync-overlap) [658.333588] Starting subtest: sync-overlap [658.335707] Subtest sync-overlap: SUCCESS (0.000s) [658.468440] [137/155] (366s left) perf_pmu (enable-race) [658.509351] Starting subtest: enable-race [658.511931] Starting dynamic subtest: rcs0 [671.275918] Dynamic subtest rcs0: SUCCESS (12.763s) [671.288194] Starting dynamic subtest: bcs0 [684.024033] Dynamic subtest bcs0: SUCCESS (12.743s) [684.035043] Starting dynamic subtest: vcs0 [700.048514] Dynamic subtest vcs0: SUCCESS (16.017s) [700.061285] Starting dynamic subtest: vcs1 [716.049606] Dynamic subtest vcs1: SUCCESS (15.994s) [716.062334] Starting dynamic subtest: vecs0 [732.050027] Dynamic subtest vecs0: SUCCESS (15.997s) [732.063359] Starting dynamic subtest: ccs0 [744.799053] Dynamic subtest ccs0: SUCCESS (12.750s) [744.801884] Subtest enable-race: SUCCESS (86.277s) [744.907362] [138/155] (280s left) kms_universal_plane (universal-plane-sanity) [745.003202] Starting subtest: universal-plane-sanity [745.005527] Starting dynamic subtest: pipe-A-eDP-1 [745.596294] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.591s) [745.609071] Starting dynamic subtest: pipe-B-eDP-1 [746.803757] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.206s) [746.815695] Starting dynamic subtest: pipe-C-eDP-1 [748.014987] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s) [748.027027] Starting dynamic subtest: pipe-D-eDP-1 [749.259337] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s) [749.261759] Subtest universal-plane-sanity: SUCCESS (4.256s) [750.120815] [139/155] (274s left) core_setmaster (master-drop-set-shared-fd) [750.210792] Starting subtest: master-drop-set-shared-fd [750.231983] Subtest master-drop-set-shared-fd: SUCCESS (0.022s) [750.285105] [140/155] (274s left) gem_exec_fence (invalid-timeline-fence-array) [750.837496] Starting subtest: invalid-timeline-fence-array [750.848102] Subtest invalid-timeline-fence-array: SUCCESS (0.009s) [752.149120] [141/155] (272s left) api_intel_allocator (reopen) [752.209753] Starting subtest: reopen [752.212685] Subtest reopen: SUCCESS (0.004s) [752.332918] [142/155] (272s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [752.427289] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [752.432287] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [752.520134] [143/155] (272s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [752.612878] Starting subtest: bad-pixel-format-yf-tiled-ccs [752.615507] Starting dynamic subtest: pipe-A-eDP-1 [752.641983] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [752.655667] Starting dynamic subtest: pipe-B-eDP-1 [752.681808] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [752.692145] Starting dynamic subtest: pipe-C-eDP-1 [752.718062] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [752.728049] Starting dynamic subtest: pipe-D-eDP-1 [752.754860] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [752.759969] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [754.876495] [144/155] (270s left) syncobj_wait (single-wait-for-submit-unsubmitted) [754.920792] Starting subtest: single-wait-for-submit-unsubmitted [755.028624] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s) [755.108783] [145/155] (270s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff) [755.209385] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff [755.214180] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [755.298855] [146/155] (270s left) kms_psr (fbc-psr2-primary-blt) [755.397656] Starting subtest: fbc-psr2-primary-blt [755.400272] Starting dynamic subtest: eDP-1 [755.405072] Dynamic subtest eDP-1: SKIP (0.000s) [755.410028] Subtest fbc-psr2-primary-blt: SKIP (0.001s) [755.471581] [147/155] (269s left) gem_blits (basic) [755.535949] Starting subtest: basic [756.942126] Subtest basic: SUCCESS (1.404s) [757.056414] [148/155] (268s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite) [757.153958] Starting subtest: psrhdr-rgb101010-draw-pwrite [757.159554] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s) [757.269313] [149/155] (268s left) kms_flip (2x-plain-flip-ts-check) [757.358730] Starting subtest: 2x-plain-flip-ts-check [757.369302] Subtest 2x-plain-flip-ts-check: SKIP (0.010s) [757.463387] [150/155] (268s left) gem_exec_schedule (submit-late-slice) [757.542930] Starting subtest: submit-late-slice [757.545738] Starting dynamic subtest: rcs0 [757.572326] Dynamic subtest rcs0: SUCCESS (0.041s) [757.585060] Starting dynamic subtest: bcs0 [757.605817] Dynamic subtest bcs0: SUCCESS (0.033s) [757.617942] Starting dynamic subtest: vcs0 [757.639733] Dynamic subtest vcs0: SUCCESS (0.033s) [757.650746] Starting dynamic subtest: vcs1 [757.673534] Dynamic subtest vcs1: SUCCESS (0.033s) [757.686024] Starting dynamic subtest: vecs0 [757.705867] Dynamic subtest vecs0: SUCCESS (0.032s) [757.717072] Starting dynamic subtest: ccs0 [757.740046] Dynamic subtest ccs0: SUCCESS (0.034s) [757.742853] Subtest submit-late-slice: SUCCESS (0.209s) [759.132384] [151/155] (266s left) gem_mmap_offset (partial-unmap) [759.188616] Starting subtest: partial-unmap [759.190731] Starting dynamic subtest: smem0 [759.698081] Dynamic subtest smem0: SUCCESS (0.510s) [759.701050] Subtest partial-unmap: SUCCESS (0.511s) [759.818595] [152/155] (265s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [759.924748] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [764.410755] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.493s) [765.599286] [153/155] (260s left) syncobj_timeline (multi-wait-all-available-signaled) [765.654632] Starting subtest: multi-wait-all-available-signaled [765.657377] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [765.742385] [154/155] (259s left) sriov_basic (enable-vfs-autoprobe-off) [765.796079] Starting subtest: enable-vfs-autoprobe-off [765.798811] Starting dynamic subtest: numvfs-1 [765.804019] Dynamic subtest numvfs-1: SKIP (0.001s) [765.815680] Starting dynamic subtest: numvfs-2 [765.820441] Dynamic subtest numvfs-2: SKIP (0.001s) [765.831663] Starting dynamic subtest: numvfs-3 [765.836820] Dynamic subtest numvfs-3: SKIP (0.001s) [765.850878] Starting dynamic subtest: numvfs-4 [765.856040] Dynamic subtest numvfs-4: SKIP (0.000s) [765.866658] Starting dynamic subtest: numvfs-5 [765.871826] Dynamic subtest numvfs-5: SKIP (0.000s) [765.882535] Starting dynamic subtest: numvfs-6 [765.887536] Dynamic subtest numvfs-6: SKIP (0.000s) [765.899629] Starting dynamic subtest: numvfs-7 [765.904223] Dynamic subtest numvfs-7: SKIP (0.000s) [765.914282] Starting dynamic subtest: numvfs-random [765.918950] Dynamic subtest numvfs-random: SKIP (0.000s) [765.929174] Starting dynamic subtest: numvfs-all [765.933872] Dynamic subtest numvfs-all: SKIP (0.001s) [765.938553] Subtest enable-vfs-autoprobe-off: SKIP (0.011s) [765.980190] [155/155] (259s left) syncobj_wait (invalid-multi-wait-unsubmitted) [766.024302] Starting subtest: invalid-multi-wait-unsubmitted [766.026818] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [766.128730] Closing watchdogs results: parsing output: 0/ for test: gem_eio results: parsing output: 1/ for test: kms_cursor_edge_walk results: parsing output: 2/ for test: kms_plane_cursor results: parsing output: 3/ for test: kms_pm_rpm results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: gem_create results: parsing output: 6/ for test: kms_psr2_sf results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_mmap_gtt results: parsing output: 9/ for test: gem_pxp results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_plane_scaling results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_caching results: parsing output: 16/ for test: perf results: parsing output: 17/ for test: kms_psr_stress_test results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: gem_ctx_shared results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_mmap_offset results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_content_protection results: parsing output: 25/ for test: gem_eio results: parsing output: 26/ for test: gem_exec_reloc results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_cursor_crc results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: i915_hangman results: parsing output: 31/ for test: gem_ringfill results: parsing output: 32/ for test: syncobj_basic results: parsing output: 33/ for test: perf results: parsing output: 34/ for test: i915_pm_rc6_residency results: parsing output: 35/ for test: kms_vblank results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_getfb results: parsing output: 38/ for test: gem_exec_gttfill results: parsing output: 39/ for test: gen9_exec_parse results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: prime_mmap results: parsing output: 42/ for test: gem_ctx_shared results: parsing output: 43/ for test: gem_exec_balancer results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_exec_schedule results: parsing output: 48/ for test: kms_cursor_legacy results: parsing output: 49/ for test: gem_exec_reloc results: parsing output: 50/ for test: kms_cursor_legacy results: parsing output: 51/ for test: gem_userptr_blits results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gem_render_copy results: parsing output: 54/ for test: kms_cursor_crc results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: gem_ctx_isolation results: parsing output: 59/ for test: kms_plane_multiple results: parsing output: 60/ for test: gem_exec_capture results: parsing output: 61/ for test: kms_pm_rpm results: parsing output: 62/ for test: perf_pmu results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: gem_spin_batch results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_fence_thrash results: parsing output: 71/ for test: kms_chamelium_color results: parsing output: 72/ for test: api_intel_bb results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_plane results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_lease results: parsing output: 79/ for test: kms_flip_scaled_crc results: parsing output: 80/ for test: kms_lease results: parsing output: 81/ for test: gem_exec_flush results: parsing output: 82/ for test: kms_vrr results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_exec_reloc results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_async_flips results: parsing output: 87/ for test: syncobj_wait results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_psr results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: kms_chamelium_frames results: parsing output: 94/ for test: kms_atomic results: parsing output: 95/ for test: gem_exec_params results: parsing output: 96/ for test: kms_invalid_mode results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_userptr_blits results: parsing output: 100/ for test: gem_mmap_gtt results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gem_userptr_blits results: parsing output: 103/ for test: kms_flip results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_psr2_sf results: parsing output: 106/ for test: kms_cursor_legacy results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: kms_atomic_transition results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: gem_exec_whisper results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: gem_exec_store results: parsing output: 116/ for test: kms_addfb_basic results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_feature_discovery results: parsing output: 120/ for test: gem_exec_balancer results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: gem_userptr_blits results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: i915_suspend results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_color_pipeline results: parsing output: 127/ for test: syncobj_timeline results: parsing output: 128/ for test: kms_plane_scaling results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: i915_drm_fdinfo results: parsing output: 133/ for test: kms_chamelium_hpd results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: gem_userptr_blits results: parsing output: 136/ for test: perf_pmu results: parsing output: 137/ for test: kms_universal_plane results: parsing output: 138/ for test: core_setmaster results: parsing output: 139/ for test: gem_exec_fence results: parsing output: 140/ for test: api_intel_allocator results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_ccs results: parsing output: 143/ for test: syncobj_wait results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_psr results: parsing output: 146/ for test: gem_blits results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_flip results: parsing output: 149/ for test: gem_exec_schedule results: parsing output: 150/ for test: gem_mmap_offset results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: syncobj_timeline results: parsing output: 153/ for test: sriov_basic results: parsing output: 154/ for test: syncobj_wait Done.