[63.445309] Initializing watchdogs [63.445369] /dev/watchdog0 [63.457893] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750] [63.462294] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.464272] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.466260] [001/130] (960s left) kms_vblank (wait-busy-hang) [63.654875] Starting subtest: wait-busy-hang [63.656286] Starting dynamic subtest: pipe-A-HDMI-A-1 [90.778505] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (27.109s) [90.785028] Starting dynamic subtest: pipe-B-HDMI-A-1 [104.580217] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (13.799s) [104.580957] Subtest wait-busy-hang: SUCCESS (40.911s) [104.784476] [002/130] (919s left) gem_render_linear_blits (basic) [104.821963] Starting subtest: basic [104.847835] Subtest basic: SUCCESS (0.026s) [104.926330] [003/130] (919s left) gem_exec_flush (basic-wb-rw-before-default) [104.967114] Starting subtest: basic-wb-rw-before-default [110.418832] Subtest basic-wb-rw-before-default: SUCCESS (5.451s) [110.663260] [004/130] (913s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [110.779834] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [110.781164] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [110.914142] [005/130] (913s left) kms_color (invalid-ctm-matrix-sizes) [111.019833] Starting subtest: invalid-ctm-matrix-sizes [111.020502] Starting dynamic subtest: pipe-A [111.021906] Dynamic subtest pipe-A: SUCCESS (0.002s) [111.026517] Starting dynamic subtest: pipe-B [111.027206] Dynamic subtest pipe-B: SUCCESS (0.003s) [111.027872] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.005s) [111.131215] [006/130] (913s left) gen7_exec_parse (basic-rejected) [111.166893] Subtest basic-rejected: SKIP (0.000s) [111.194735] [007/130] (913s left) gem_exec_fence (syncobj-channel) [111.530727] Starting subtest: syncobj-channel [112.553736] Subtest syncobj-channel: SUCCESS (1.021s) [112.893646] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true [112.895085] [008/130] (911s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [113.005117] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [113.006420] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [113.162924] [009/130] (911s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [113.268984] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [113.270380] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [113.428529] [010/130] (910s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [113.536026] Starting subtest: modeset-transition-nonblocking-fencing [113.536751] Starting dynamic subtest: 1x-outputs [114.205581] Dynamic subtest 1x-outputs: SUCCESS (0.668s) [114.234685] Subtest modeset-transition-nonblocking-fencing: SUCCESS (0.698s) [114.397490] [011/130] (909s left) gem_pxp (reject-modify-context-protection-off-3) [295.230150] Per-test timeout exceeded. Killing the current test with SIGQUIT. [304.758042] Closing watchdogs [304.762290] Initializing watchdogs [304.762327] /dev/watchdog0 [304.774871] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750] [304.780402] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [304.782527] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [304.783015] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true [304.784309] [012/130] (719s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [304.935675] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [305.016260] [013/130] (719s left) kms_cursor_crc (cursor-rapid-movement-256x256) [305.127930] Starting subtest: cursor-rapid-movement-256x256 [305.130163] Starting dynamic subtest: pipe-A-HDMI-A-1 [305.549534] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.419s) [305.576397] Starting dynamic subtest: pipe-B-HDMI-A-1 [305.883177] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.311s) [305.884154] Subtest cursor-rapid-movement-256x256: SUCCESS (0.755s) [306.067719] [014/130] (718s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [306.173814] Starting subtest: primary-x-tiled-reflect-x-180 [314.099356] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.925s) [314.328151] [015/130] (710s left) gem_workarounds (reset) [314.378303] Starting subtest: reset [314.385315] Subtest reset: SUCCESS (0.006s) [314.583810] [016/130] (710s left) kms_big_fb (x-tiled-64bpp-rotate-90) [314.696273] Starting subtest: x-tiled-64bpp-rotate-90 [314.770167] Subtest x-tiled-64bpp-rotate-90: SKIP (0.073s) [314.951210] [017/130] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [315.061367] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [315.062690] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [315.203120] [018/130] (709s left) gem_fenced_exec_thrash (too-many-fences) [315.237535] Starting subtest: too-many-fences [317.391716] Subtest too-many-fences: SUCCESS (2.153s) [317.583050] [019/130] (707s left) drm_mm (drm_mm) [317.615488] Starting subtest: drm_mm [317.618773] Starting dynamic subtest: drm_test_mm_init [317.740682] Dynamic subtest drm_test_mm_init: SUCCESS (0.121s) [317.745849] Starting dynamic subtest: drm_test_mm_debug [317.855716] Dynamic subtest drm_test_mm_debug: SUCCESS (0.114s) [317.872424] Starting dynamic subtest: drm_test_mm_align32 [318.008691] Dynamic subtest drm_test_mm_align32: SUCCESS (0.131s) [318.025116] Starting dynamic subtest: drm_test_mm_align64 [318.090777] Dynamic subtest drm_test_mm_align64: SUCCESS (0.101s) [318.108122] Starting dynamic subtest: drm_test_mm_lowest [318.244794] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.137s) [318.262961] Starting dynamic subtest: drm_test_mm_highest [318.355385] Dynamic subtest drm_test_mm_highest: SUCCESS (0.126s) [318.356339] Subtest drm_mm: SUCCESS (0.739s) [318.529433] [020/130] (706s left) drm_buddy (drm_buddy) [318.561365] Starting subtest: drm_buddy [318.563671] Starting dynamic subtest: drm_test_buddy_alloc_limit [318.701415] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.116s) [318.709180] Starting dynamic subtest: drm_test_buddy_alloc_optimistic [318.800270] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.118s) [318.818043] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic [318.908435] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.107s) [318.925985] Starting dynamic subtest: drm_test_buddy_alloc_pathological [319.019458] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.111s) [319.038932] Starting dynamic subtest: drm_test_buddy_alloc_contiguous [319.107913] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.085s) [319.125389] Starting dynamic subtest: drm_test_buddy_alloc_clear [319.228484] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.122s) [319.233453] Starting dynamic subtest: drm_test_buddy_alloc_range_bias [319.339438] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.109s) [319.340715] Subtest drm_buddy: SUCCESS (0.778s) [319.531485] [021/130] (705s left) kms_getfb (getfb-handle-zero) [319.564301] Starting subtest: getfb-handle-zero [319.565006] Subtest getfb-handle-zero: SUCCESS (0.000s) [319.694222] [022/130] (705s left) kms_psr (fbc-psr2-basic) [319.802514] Subtest fbc-psr2-basic: SKIP (0.000s) [319.858841] [023/130] (705s left) api_intel_bb (intel-bb-blit-none) [319.892204] Starting subtest: intel-bb-blit-none [322.800401] Subtest intel-bb-blit-none: SUCCESS (2.908s) [322.963367] [024/130] (701s left) kms_big_fb (x-tiled-16bpp-rotate-90) [323.080151] Starting subtest: x-tiled-16bpp-rotate-90 [323.143700] Subtest x-tiled-16bpp-rotate-90: SKIP (0.063s) [323.292187] [025/130] (701s left) gem_exec_whisper (basic-sync-all) [323.333141] Starting subtest: basic-sync-all [324.458817] Subtest basic-sync-all: SUCCESS (1.126s) [324.657387] [026/130] (700s left) kms_atomic (crtc-invalid-params-fence) [324.765950] Starting subtest: crtc-invalid-params-fence [324.766742] Starting dynamic subtest: pipe-A-HDMI-A-1 [324.962240] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.194s) [324.963170] Subtest crtc-invalid-params-fence: SUCCESS (0.195s) [325.142762] [027/130] (699s left) kms_dp_link_training (uhbr-mst) [325.250010] Starting subtest: uhbr-mst [325.251477] Subtest uhbr-mst: SKIP (0.000s) [325.343765] [028/130] (699s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [325.450018] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [325.450776] Starting dynamic subtest: pipe-A [325.879973] Dynamic subtest pipe-A: SKIP (0.428s) [325.885323] Starting dynamic subtest: pipe-B [326.514325] Dynamic subtest pipe-B: SKIP (0.634s) [326.515674] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (1.063s) [326.635619] [029/130] (698s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [326.747687] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [326.749013] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [326.863164] [030/130] (698s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [326.974379] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [326.976651] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.001s) [327.091193] [031/130] (698s left) kms_flip (dpms-off-confusion) [327.199664] Starting subtest: dpms-off-confusion [327.201727] Starting dynamic subtest: A-HDMI-A1 [342.411288] Dynamic subtest A-HDMI-A1: SUCCESS (15.210s) [342.420815] Starting dynamic subtest: B-HDMI-A1 [357.584374] Dynamic subtest B-HDMI-A1: SUCCESS (15.168s) [357.588172] Subtest dpms-off-confusion: SUCCESS (30.387s) [357.765038] [032/130] (667s left) kms_getfb (getfb-addfb-different-handles) [357.797502] Starting subtest: getfb-addfb-different-handles [357.798210] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [357.929584] [033/130] (667s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [357.963538] Starting subtest: invalid-multi-wait-unsubmitted-submitted [357.964231] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [358.059765] [034/130] (667s left) gem_exec_fence (basic-await) [358.227200] Starting subtest: basic-await [358.228121] Starting dynamic subtest: rcs0 [358.313623] Dynamic subtest rcs0: SUCCESS (0.085s) [358.330201] Starting dynamic subtest: bcs0 [358.400395] Dynamic subtest bcs0: SUCCESS (0.084s) [358.417856] Starting dynamic subtest: vcs0 [358.487131] Dynamic subtest vcs0: SUCCESS (0.083s) [358.505430] Starting dynamic subtest: vecs0 [358.574543] Dynamic subtest vecs0: SUCCESS (0.084s) [358.576122] Subtest basic-await: SUCCESS (0.348s) [359.068972] [035/130] (666s left) kms_prop_blob (blob-prop-validate) [359.102609] Starting subtest: blob-prop-validate [359.103313] Subtest blob-prop-validate: SUCCESS (0.000s) [359.199505] [036/130] (666s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [359.240251] Starting subtest: y-tiled-ccs-to-x-tiled [359.240965] Starting dynamic subtest: smem [359.369430] Dynamic subtest smem: SUCCESS (0.129s) [359.370155] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.129s) [359.587614] [037/130] (665s left) gem_exec_schedule (u-semaphore-user) [359.634921] Starting subtest: u-semaphore-user [359.640515] Subtest u-semaphore-user: SUCCESS (0.006s) [359.977126] [038/130] (665s left) kms_big_fb (yf-tiled-addfb-size-overflow) [360.092803] Starting subtest: yf-tiled-addfb-size-overflow [360.094150] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [360.244786] [039/130] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [360.356684] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [360.357993] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [360.497809] [040/130] (664s left) gem_softpin (allocator-evict) [360.538879] Starting subtest: allocator-evict [360.539562] Starting dynamic subtest: rcs0 [385.638191] Dynamic subtest rcs0: SUCCESS (25.098s) [385.644215] Starting dynamic subtest: bcs0 [410.952351] Dynamic subtest bcs0: SUCCESS (25.313s) [410.958514] Starting dynamic subtest: vcs0 [436.386226] Dynamic subtest vcs0: SUCCESS (25.433s) [436.392280] Starting dynamic subtest: vecs0 [461.380326] Dynamic subtest vecs0: SUCCESS (24.993s) [461.381073] Subtest allocator-evict: SUCCESS (100.840s) [461.456856] [041/130] (564s left) gem_exec_parallel (basic) [461.518183] Starting subtest: basic [461.518989] Starting dynamic subtest: rcs0 [462.941136] Dynamic subtest rcs0: SUCCESS (1.423s) [462.946877] Starting dynamic subtest: bcs0 [464.353754] Dynamic subtest bcs0: SUCCESS (1.412s) [464.365677] Starting dynamic subtest: vcs0 [465.761777] Dynamic subtest vcs0: SUCCESS (1.407s) [465.778378] Starting dynamic subtest: vecs0 [467.138548] Dynamic subtest vecs0: SUCCESS (1.376s) [467.139316] Subtest basic: SUCCESS (5.621s) [467.359054] [042/130] (558s left) gem_userptr_blits (sync-overlap) [467.404209] Starting subtest: sync-overlap [467.404913] Subtest sync-overlap: SUCCESS (0.000s) [467.553247] [043/130] (558s left) kms_flip (bo-too-big-interruptible) [467.667312] Starting subtest: bo-too-big-interruptible [467.668989] Starting dynamic subtest: A-HDMI-A1 [468.517270] Dynamic subtest A-HDMI-A1: SUCCESS (0.848s) [468.529942] Starting dynamic subtest: B-HDMI-A1 [469.306734] Dynamic subtest B-HDMI-A1: SUCCESS (0.786s) [469.311100] Subtest bo-too-big-interruptible: SUCCESS (1.642s) [469.538290] [044/130] (556s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [469.650146] Starting subtest: fbcpsr-rgb565-draw-pwrite [469.651468] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s) [469.787283] [045/130] (555s left) gem_pipe_control_store_loop (reused-buffer) [469.822752] Starting subtest: reused-buffer [471.972017] Subtest reused-buffer: SUCCESS (2.149s) [472.144077] [046/130] (553s left) perf (low-oa-exponent-permissions) [472.256209] Starting subtest: low-oa-exponent-permissions [472.301406] Subtest low-oa-exponent-permissions: SUCCESS (0.045s) [472.359622] [047/130] (553s left) kms_fbcon_fbt (psr) [472.396160] Starting subtest: psr [472.397539] Subtest psr: SKIP (0.000s) [472.537549] [048/130] (553s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [472.687520] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [472.767090] [049/130] (553s left) gem_huc_copy (huc-copy) [472.805722] Starting subtest: huc-copy [472.807063] Subtest huc-copy: SKIP (0.000s) [472.956942] [050/130] (552s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [473.068708] Starting subtest: fbc-rgb565-draw-blt [475.601689] Subtest fbc-rgb565-draw-blt: SUCCESS (2.533s) [475.761238] [051/130] (550s left) syncobj_wait (wait-any-snapshot) [475.795472] Starting subtest: wait-any-snapshot [475.877384] Subtest wait-any-snapshot: SUCCESS (0.081s) [475.977813] [052/130] (549s left) gem_exec_balancer (full-late-pulse) [476.025349] Starting subtest: full-late-pulse [477.499867] Subtest full-late-pulse: SUCCESS (1.474s) [477.722068] [053/130] (548s left) i915_query (engine-info-invalid) [477.755388] Starting subtest: engine-info-invalid [477.756081] Subtest engine-info-invalid: SUCCESS (0.000s) [477.851563] [054/130] (548s left) gem_pread (snoop) [477.884950] Subtest snoop: SKIP (0.000s) [477.975065] [055/130] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [478.084712] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [478.086027] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [478.217888] [056/130] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [478.327725] Starting subtest: fbc-2p-primscrn-cur-indfb-move [478.329043] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [478.478550] [057/130] (547s left) i915_getparams_basic (basic-eu-total) [478.513620] Starting subtest: basic-eu-total [478.515041] Subtest basic-eu-total: SUCCESS (0.000s) [478.616454] [058/130] (547s left) vgem_basic (mmap) [478.656279] Starting subtest: mmap [478.668356] Subtest mmap: SUCCESS (0.012s) [478.730776] [059/130] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [478.841688] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [478.842992] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s) [478.997057] [060/130] (547s left) gem_eio (in-flight-contexts-immediate) [479.036841] Starting subtest: in-flight-contexts-immediate [490.861045] Subtest in-flight-contexts-immediate: SUCCESS (11.824s) [491.047459] [061/130] (535s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [491.158678] Starting subtest: psr-rgb101010-draw-render [491.159975] Subtest psr-rgb101010-draw-render: SKIP (0.000s) [491.301336] [062/130] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [491.411683] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [491.413030] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [491.557356] [063/130] (534s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [491.664561] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [491.665973] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [491.764460] [064/130] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [491.876771] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [491.878106] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [492.009889] [065/130] (534s left) prime_busy (hang) [492.046088] Starting subtest: hang [492.046801] Starting dynamic subtest: rcs0 [518.751766] Dynamic subtest rcs0: SUCCESS (26.703s) [518.758414] Starting dynamic subtest: bcs0 [525.535516] Dynamic subtest bcs0: SUCCESS (6.783s) [525.542068] Starting dynamic subtest: vcs0 [532.575318] Dynamic subtest vcs0: SUCCESS (7.039s) [532.581872] Starting dynamic subtest: vecs0 [539.551463] Dynamic subtest vecs0: SUCCESS (6.975s) [539.552196] Subtest hang: SUCCESS (47.503s) [539.704870] [066/130] (486s left) kms_psr2_sf (pr-cursor-plane-update-sf) [539.815826] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [539.858834] [067/130] (486s left) perf (stress-open-close) [539.952393] Starting subtest: stress-open-close [539.953114] Starting dynamic subtest: 0-rcs0 [542.135533] Dynamic subtest 0-rcs0: SUCCESS (2.183s) [542.136232] Subtest stress-open-close: SUCCESS (2.183s) [542.175930] [068/130] (484s left) sysfs_heartbeat_interval (idempotent) [542.211362] Starting subtest: idempotent [542.213129] Starting dynamic subtest: vecs0 [542.213852] Dynamic subtest vecs0: SUCCESS (0.001s) [542.220881] Starting dynamic subtest: vcs0 [542.221573] Dynamic subtest vcs0: SUCCESS (0.001s) [542.228375] Starting dynamic subtest: bcs0 [542.229048] Dynamic subtest bcs0: SUCCESS (0.001s) [542.235524] Starting dynamic subtest: rcs0 [542.236191] Dynamic subtest rcs0: SUCCESS (0.001s) [542.236863] Subtest idempotent: SUCCESS (0.006s) [542.303692] [069/130] (484s left) gem_exec_reloc (basic-write-cpu) [542.341741] Subtest basic-write-cpu: SKIP (0.000s) [542.440117] [070/130] (484s left) gem_reg_read (timestamp-moving) [542.474890] Starting subtest: timestamp-moving [543.475425] Subtest timestamp-moving: SUCCESS (1.000s) [543.576026] [071/130] (483s left) kms_pm_dc (dc3co-vpb-simulation) [544.696717] Starting subtest: dc3co-vpb-simulation [544.698113] Subtest dc3co-vpb-simulation: SKIP (0.000s) [544.787849] [072/130] (481s left) kms_pm_rpm (cursor) [546.237257] Starting subtest: cursor [548.029163] Subtest cursor: SUCCESS (1.792s) [548.224514] [073/130] (478s left) kms_plane_alpha_blend (constant-alpha-min) [548.335132] Starting subtest: constant-alpha-min [548.425680] Starting dynamic subtest: pipe-A-HDMI-A-1 [549.155910] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.731s) [549.162821] Starting dynamic subtest: pipe-B-HDMI-A-1 [549.895852] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.732s) [549.896740] Subtest constant-alpha-min: SUCCESS (1.554s) [550.099944] [074/130] (476s left) gem_exec_reloc (basic-concurrent16) [550.135899] Subtest basic-concurrent16: SKIP (0.000s) [550.234329] [075/130] (476s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [550.346081] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [550.347431] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [550.479542] [076/130] (476s left) kms_psr (fbc-psr-cursor-plane-onoff) [550.588552] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [550.654158] [077/130] (476s left) kms_vblank (ts-continuation-suspend) [550.763128] Starting subtest: ts-continuation-suspend [550.764831] Starting dynamic subtest: pipe-A-HDMI-A-1 [568.465614] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (17.701s) [568.475422] Starting dynamic subtest: pipe-B-HDMI-A-1 [585.441877] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (16.973s) [585.442624] Subtest ts-continuation-suspend: SUCCESS (34.677s) [590.616624] [078/130] (441s left) gem_exec_schedule (preempt-contexts) [590.663693] Starting subtest: preempt-contexts [590.664418] Starting dynamic subtest: rcs0 [590.691089] Dynamic subtest rcs0: SUCCESS (0.027s) [590.699703] Starting dynamic subtest: bcs0 [590.719285] Dynamic subtest bcs0: SUCCESS (0.027s) [590.728872] Starting dynamic subtest: vcs0 [590.745980] Dynamic subtest vcs0: SUCCESS (0.025s) [590.754318] Starting dynamic subtest: vecs0 [590.771803] Dynamic subtest vecs0: SUCCESS (0.026s) [590.772502] Subtest preempt-contexts: SUCCESS (0.109s) [591.110417] [079/130] (440s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [591.219114] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [591.220858] Starting dynamic subtest: pipe-A-HDMI-A-1 [592.437276] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.213s) [592.452302] Starting dynamic subtest: pipe-B-HDMI-A-1 [593.171844] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.730s) [593.173130] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SUCCESS (1.950s) [593.415958] [080/130] (438s left) kms_cursor_crc (cursor-onscreen-32x10) [593.525794] Starting subtest: cursor-onscreen-32x10 [593.557757] Subtest cursor-onscreen-32x10: SKIP (0.030s) [593.712985] [081/130] (438s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [593.749720] Starting subtest: etime-multi-wait-all-submitted-signaled [593.856117] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s) [593.958869] [082/130] (438s left) gem_partial_pwrite_pread (write) [593.994531] Subtest write: SKIP (0.000s) [594.089461] [083/130] (438s left) gem_mmap_wc (pf-nonblock) [594.124627] Starting subtest: pf-nonblock [594.126320] Subtest pf-nonblock: SUCCESS (0.002s) [594.307708] [084/130] (437s left) gem_barrier_race (remote-request) [594.344606] Starting subtest: remote-request [594.345290] Starting dynamic subtest: rcs0 [599.511596] Dynamic subtest rcs0: SUCCESS (5.166s) [599.512393] Subtest remote-request: SUCCESS (5.167s) [599.724812] [085/130] (432s left) kms_big_fb (y-tiled-64bpp-rotate-270) [599.841979] Starting subtest: y-tiled-64bpp-rotate-270 [599.909013] Subtest y-tiled-64bpp-rotate-270: SKIP (0.066s) [600.081693] [086/130] (432s left) tools_test (sysfs_l3_parity) [600.119302] Starting subtest: sysfs_l3_parity [600.164213] Subtest sysfs_l3_parity: SKIP (0.048s) [600.257834] [087/130] (432s left) kms_flip (2x-busy-flip) [600.367499] Starting subtest: 2x-busy-flip [600.368835] Subtest 2x-busy-flip: SKIP (0.001s) [600.505856] [088/130] (431s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [600.618739] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [602.746650] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (2.129s) [602.971717] [089/130] (429s left) kms_tiled_display (basic-test-pattern) [603.136449] Subtest basic-test-pattern: SKIP (0.000s) [603.200852] [090/130] (429s left) kms_busy (basic-hang) [603.311398] Starting subtest: basic-hang [603.313133] Starting dynamic subtest: flip-pipe-A [603.854632] Dynamic subtest flip-pipe-A: SUCCESS (0.540s) [603.863701] Starting dynamic subtest: modeset-pipe-A [604.490502] Dynamic subtest modeset-pipe-A: SUCCESS (0.635s) [604.502698] Starting dynamic subtest: flip-pipe-B [604.901724] Dynamic subtest flip-pipe-B: SUCCESS (0.408s) [604.911453] Starting dynamic subtest: modeset-pipe-B [605.490616] Dynamic subtest modeset-pipe-B: SUCCESS (0.588s) [605.491376] Subtest basic-hang: SUCCESS (2.179s) [605.709738] [091/130] (426s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [605.822019] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s) [605.877009] [092/130] (426s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [605.987716] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [605.989056] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [606.127649] [093/130] (426s left) gem_ctx_persistence (engines-hostile) [606.165495] Starting subtest: engines-hostile [606.166206] Starting dynamic subtest: rcs0 [606.298397] Dynamic subtest rcs0: SUCCESS (0.132s) [606.312218] Starting dynamic subtest: bcs0 [606.424695] Dynamic subtest bcs0: SUCCESS (0.123s) [606.448861] Starting dynamic subtest: vcs0 [606.544384] Dynamic subtest vcs0: SUCCESS (0.117s) [606.570364] Starting dynamic subtest: vecs0 [606.672373] Dynamic subtest vecs0: SUCCESS (0.125s) [606.676464] Subtest engines-hostile: SUCCESS (0.508s) [606.792423] [094/130] (425s left) gem_ctx_sseu (mmap-args) [606.828853] Subtest mmap-args: SKIP (0.000s) [606.884653] [095/130] (425s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [606.992167] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [606.993864] Starting dynamic subtest: pipe-A-HDMI-A-1 [607.001161] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [607.008986] Starting dynamic subtest: pipe-B-HDMI-A-1 [607.016227] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [607.017531] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.002s) [607.236090] [096/130] (425s left) i915_query (query-topology-known-pci-ids) [607.269167] Starting subtest: query-topology-known-pci-ids [607.270512] Subtest query-topology-known-pci-ids: SKIP (0.000s) [607.360127] [097/130] (425s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [607.472734] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [607.474096] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [607.634365] [098/130] (425s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [607.744278] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [607.745967] Starting dynamic subtest: pipe-A-valid-mode [607.804283] Dynamic subtest pipe-A-valid-mode: SKIP (0.057s) [607.805946] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.059s) [607.942068] [099/130] (425s left) core_getversion (basic) [607.975930] Starting subtest: basic [607.977259] Subtest basic: SUCCESS (0.000s) [608.072950] [100/130] (424s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [608.183725] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [608.185031] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [608.313761] [101/130] (424s left) gem_exec_flush (basic-uc-pro-default) [608.356440] Starting subtest: basic-uc-pro-default [613.823432] Subtest basic-uc-pro-default: SUCCESS (5.467s) [614.080226] [102/130] (419s left) kms_psr (psr2-sprite-plane-onoff) [614.189620] Subtest psr2-sprite-plane-onoff: SKIP (0.000s) [614.240596] [103/130] (418s left) perf_pmu (busy-idle-no-semaphores) [614.284275] Starting subtest: busy-idle-no-semaphores [614.284941] Starting dynamic subtest: rcs0 [614.947367] Dynamic subtest rcs0: SUCCESS (0.670s) [614.960484] Starting dynamic subtest: bcs0 [615.584933] Dynamic subtest bcs0: SUCCESS (0.635s) [615.598453] Starting dynamic subtest: vcs0 [616.209132] Dynamic subtest vcs0: SUCCESS (0.621s) [616.223731] Starting dynamic subtest: vecs0 [616.831425] Dynamic subtest vecs0: SUCCESS (0.619s) [616.835982] Subtest busy-idle-no-semaphores: SUCCESS (2.556s) [616.966186] [104/130] (416s left) kms_content_protection (dp-mst-lic-type-0) [617.083351] Starting subtest: dp-mst-lic-type-0 [617.084686] Subtest dp-mst-lic-type-0: SKIP (0.000s) [617.233960] [105/130] (415s left) gem_ctx_isolation (dirty-create) [617.275643] Starting subtest: dirty-create [617.276347] Starting dynamic subtest: rcs0 [617.668739] Dynamic subtest rcs0: SUCCESS (0.393s) [617.676657] Starting dynamic subtest: bcs0 [618.144624] Dynamic subtest bcs0: SUCCESS (0.475s) [618.152503] Starting dynamic subtest: vcs0 [618.614570] Dynamic subtest vcs0: SUCCESS (0.469s) [618.622788] Starting dynamic subtest: vecs0 [619.094637] Dynamic subtest vecs0: SUCCESS (0.479s) [619.095389] Subtest dirty-create: SUCCESS (1.819s) [619.300766] [106/130] (413s left) kms_frontbuffer_tracking (pipe-fbc-rte) [619.413729] Starting subtest: pipe-fbc-rte [619.416310] Subtest pipe-fbc-rte: SKIP (0.000s) [619.552905] [107/130] (413s left) gem_create (create-valid-nonaligned) [619.585571] Starting subtest: create-valid-nonaligned [619.586290] Subtest create-valid-nonaligned: SUCCESS (0.000s) [619.823208] [108/130] (413s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [619.931125] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [619.932470] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [620.129512] [109/130] (413s left) vgem_basic (second-client) [620.169041] Starting subtest: second-client [620.211091] Subtest second-client: SUCCESS (0.038s) [620.298041] [110/130] (413s left) kms_lease (lease-invalid-crtc) [620.404309] Starting subtest: lease-invalid-crtc [620.406050] Starting dynamic subtest: pipe-A-HDMI-A-1 [620.406746] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [620.414708] Starting dynamic subtest: pipe-B-HDMI-A-1 [620.415459] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [620.416234] Subtest lease-invalid-crtc: SUCCESS (0.002s) [620.506119] [111/130] (412s left) kms_psr (fbc-psr-sprite-render) [620.614535] Subtest fbc-psr-sprite-render: SKIP (0.000s) [620.653090] [112/130] (412s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [620.765820] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [620.767162] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [620.927925] [113/130] (412s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [621.035348] Starting subtest: addfb25-y-tiled-small-legacy [621.036050] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [621.174920] [114/130] (412s left) gem_ctx_persistence (legacy-engines-persistence) [621.211876] Starting subtest: legacy-engines-persistence [621.212569] Starting dynamic subtest: render [621.989560] Dynamic subtest render: SUCCESS (0.776s) [621.999887] Starting dynamic subtest: bsd [622.796405] Dynamic subtest bsd: SUCCESS (0.804s) [622.809750] Starting dynamic subtest: blt [623.578399] Dynamic subtest blt: SUCCESS (0.779s) [623.591621] Starting dynamic subtest: vebox [624.337406] Dynamic subtest vebox: SUCCESS (0.756s) [624.341584] Subtest legacy-engines-persistence: SUCCESS (3.126s) [624.441803] [115/130] (409s left) gem_render_copy (linear-to-vebox-y-tiled) [624.488168] Starting subtest: linear-to-vebox-y-tiled [624.488874] Starting dynamic subtest: smem [624.613882] Dynamic subtest smem: SUCCESS (0.125s) [624.614593] Subtest linear-to-vebox-y-tiled: SUCCESS (0.126s) [624.836286] [116/130] (408s left) gem_mmap_gtt (zero-extend) [624.870671] Starting subtest: zero-extend [624.871351] Subtest zero-extend: SUCCESS (0.000s) [625.005812] [117/130] (408s left) kms_rotation_crc (sprite-rotation-180) [625.112130] Starting subtest: sprite-rotation-180 [630.430417] Subtest sprite-rotation-180: SUCCESS (5.318s) [630.671226] [118/130] (403s left) gem_basic (bad-close) [630.704533] Starting subtest: bad-close [630.705878] Subtest bad-close: SUCCESS (0.000s) [630.797097] [119/130] (403s left) kms_feature_discovery (display-1x) [630.907698] Starting subtest: display-1x [630.908375] Subtest display-1x: SUCCESS (0.000s) [631.011833] [120/130] (402s left) kms_plane (pixel-format) [631.119112] Starting subtest: pixel-format [631.166492] Starting dynamic subtest: pipe-A-plane-0 [638.451411] Dynamic subtest pipe-A-plane-0: SUCCESS (7.285s) [638.476491] Starting dynamic subtest: pipe-A-plane-3 [642.037619] Dynamic subtest pipe-A-plane-3: SUCCESS (3.583s) [642.061073] Starting dynamic subtest: pipe-A-plane-5 [642.284125] Dynamic subtest pipe-A-plane-5: SUCCESS (0.244s) [642.473449] Starting dynamic subtest: pipe-B-plane-0 [649.489627] Dynamic subtest pipe-B-plane-0: SUCCESS (7.038s) [649.504824] Starting dynamic subtest: pipe-B-plane-3 [653.018921] Dynamic subtest pipe-B-plane-3: SUCCESS (3.526s) [653.041450] Starting dynamic subtest: pipe-B-plane-5 [653.265618] Dynamic subtest pipe-B-plane-5: SUCCESS (0.243s) [653.311866] Subtest pixel-format: SUCCESS (22.191s) [653.483363] [121/130] (380s left) gem_spin_batch (resubmit-new) [653.525124] Starting subtest: resubmit-new [653.525901] Starting dynamic subtest: rcs0 [653.528208] Dynamic subtest rcs0: SUCCESS (0.003s) [653.537549] Starting dynamic subtest: bcs0 [653.538237] Dynamic subtest bcs0: SUCCESS (0.001s) [653.545939] Starting dynamic subtest: vcs0 [653.546615] Dynamic subtest vcs0: SUCCESS (0.001s) [653.554186] Starting dynamic subtest: vecs0 [653.554857] Dynamic subtest vecs0: SUCCESS (0.002s) [653.555518] Subtest resubmit-new: SUCCESS (0.010s) [653.747218] [122/130] (380s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [653.855211] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [653.856915] Starting dynamic subtest: pipe-A-HDMI-A-1 [653.863478] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [653.871488] Starting dynamic subtest: pipe-B-HDMI-A-1 [653.877988] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [653.879312] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.002s) [654.096911] [123/130] (379s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [654.208748] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [654.210047] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [654.356336] [124/130] (379s left) sysfs_heartbeat_interval (precise) [654.392471] Starting subtest: precise [654.393180] Starting dynamic subtest: vecs0 [655.989372] Dynamic subtest vecs0: SUCCESS (1.593s) [656.001752] Starting dynamic subtest: vcs0 [657.598220] Dynamic subtest vcs0: SUCCESS (1.606s) [657.610692] Starting dynamic subtest: bcs0 [659.229536] Dynamic subtest bcs0: SUCCESS (1.628s) [659.241947] Starting dynamic subtest: rcs0 [660.869287] Dynamic subtest rcs0: SUCCESS (1.637s) [660.870502] Subtest precise: SUCCESS (6.475s) [660.971025] [125/130] (373s left) kms_psr (psr2-sprite-mmap-cpu) [661.077494] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s) [661.139606] [126/130] (372s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [661.174013] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [661.174742] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [661.294496] [127/130] (372s left) syncobj_timeline (invalid-transfer-non-existent-point) [661.327438] Starting subtest: invalid-transfer-non-existent-point [661.328125] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [661.439826] [128/130] (372s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [661.474273] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [661.474975] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [661.563481] [129/130] (372s left) kms_invalid_mode (int-max-clock) [661.670563] Starting subtest: int-max-clock [661.671263] Starting dynamic subtest: pipe-A-HDMI-A-1 [661.719730] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.048s) [661.733223] Starting dynamic subtest: pipe-B-HDMI-A-1 [661.733992] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [661.734691] Subtest int-max-clock: SUCCESS (0.053s) [661.905260] [130/130] (372s left) i915_pm_rpm (debugfs-forcewake-user) [663.338295] Starting subtest: debugfs-forcewake-user [673.762435] Subtest debugfs-forcewake-user: SUCCESS (10.424s) [673.965503] Closing watchdogs Done.