[66.155312] Initializing watchdogs [66.155364] /dev/watchdog0 [66.169027] [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] [66.173241] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [66.175243] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [66.177022] [001/130] (960s left) perf (non-zero-reason) [66.349308] Starting subtest: non-zero-reason [66.350014] Starting dynamic subtest: 0-rcs0 [73.464611] Dynamic subtest 0-rcs0: SUCCESS (7.115s) [73.465328] Subtest non-zero-reason: SUCCESS (7.115s) [73.496101] [002/130] (953s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [73.603292] Starting subtest: basic-flip-before-cursor-varying-size [74.675150] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.071s) [74.843553] [003/130] (951s left) gem_render_tiled_blits (basic) [74.879367] Starting subtest: basic [74.900802] Subtest basic: SUCCESS (0.021s) [74.988560] [004/130] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [75.099472] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [75.100804] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [75.200742] [005/130] (951s left) core_hotunplug (unbind-rebind) [75.275067] Starting subtest: unbind-rebind [80.670839] Subtest unbind-rebind: SUCCESS (5.397s) [80.698847] [006/130] (946s left) kms_atomic_interruptible (legacy-cursor) [80.807390] Starting subtest: legacy-cursor [80.808074] Starting dynamic subtest: pipe-A-HDMI-A-1 [87.009017] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.201s) [87.010060] Subtest legacy-cursor: SUCCESS (6.202s) [87.206161] [007/130] (939s left) kms_cursor_crc (cursor-random-max-size) [87.318452] Starting subtest: cursor-random-max-size [87.320420] Subtest cursor-random-max-size: SKIP (0.000s) [87.460540] [008/130] (939s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [87.572387] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [90.028330] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.456s) [90.219242] [009/130] (936s left) kms_content_protection (mei-interface) [90.337963] Starting subtest: mei-interface [90.489522] Subtest mei-interface: SKIP (0.148s) [90.713511] [010/130] (936s left) kms_rotation_crc (bad-tiling) [90.820836] Starting subtest: bad-tiling [92.974037] Subtest bad-tiling: SUCCESS (2.153s) [93.188211] [011/130] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [93.298360] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [93.299668] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [93.430916] [012/130] (933s left) kms_big_fb (x-tiled-64bpp-rotate-180) [93.546425] Starting subtest: x-tiled-64bpp-rotate-180 [96.232877] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.686s) [96.485811] [013/130] (930s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [96.595813] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [96.597211] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [96.713138] [014/130] (930s left) kms_psr (fbc-psr2-suspend) [96.818454] Subtest fbc-psr2-suspend: SKIP (0.000s) [96.860601] [015/130] (930s left) kms_addfb_basic (master-rmfb) [96.894608] Starting subtest: master-rmfb [96.895313] Subtest master-rmfb: SUCCESS (0.000s) [97.116078] [016/130] (930s left) gem_pread (snoop) [97.150009] Subtest snoop: SKIP (0.000s) [97.208982] [017/130] (930s left) kms_getfb (getfb-handle-zero) [97.241201] Starting subtest: getfb-handle-zero [97.241894] Subtest getfb-handle-zero: SUCCESS (0.000s) [97.386123] [018/130] (929s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [97.420123] Starting subtest: etime-single-wait-for-submit-submitted [97.526728] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s) [97.629699] [019/130] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [97.740388] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [97.741713] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [97.857744] [020/130] (929s left) kms_dp_linktrain_fallback (dp-fallback) [97.963157] Starting subtest: dp-fallback [97.965268] Subtest dp-fallback: SKIP (0.000s) [98.066258] [021/130] (929s left) gem_ctx_persistence (legacy-engines-mixed) [98.101802] Starting subtest: legacy-engines-mixed [98.102568] Starting dynamic subtest: render [98.161574] Dynamic subtest render: SUCCESS (0.059s) [98.180136] Starting dynamic subtest: bsd [98.219616] Dynamic subtest bsd: SUCCESS (0.057s) [98.233076] Starting dynamic subtest: blt [98.296531] Dynamic subtest blt: SUCCESS (0.076s) [98.315852] Starting dynamic subtest: vebox [98.385428] Dynamic subtest vebox: SUCCESS (0.088s) [98.386870] Subtest legacy-engines-mixed: SUCCESS (0.283s) [98.505070] [022/130] (928s left) gem_mmap_wc (set-cache-level) [98.537739] Starting subtest: set-cache-level [98.539285] Subtest set-cache-level: SUCCESS (0.001s) [98.693607] [023/130] (928s left) prime_mmap (test_dup) [98.725814] Starting subtest: test_dup [98.726473] Starting dynamic subtest: test_dup-smem [98.772652] Dynamic subtest test_dup-smem: SUCCESS (0.047s) [98.773353] Subtest test_dup: SUCCESS (0.047s) [98.851876] [024/130] (928s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [98.961595] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [101.659466] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.699s) [101.880294] [025/130] (925s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [101.995046] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [101.995923] Starting dynamic subtest: pipe-A-HDMI-A-1 [102.002476] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [102.007808] Starting dynamic subtest: pipe-B-HDMI-A-1 [102.014254] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [102.015530] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.002s) [102.218719] [026/130] (925s left) gem_userptr_blits (sd-probe) [102.255419] Starting subtest: sd-probe [102.256111] Subtest sd-probe: SUCCESS (0.000s) [102.433150] [027/130] (925s left) kms_hdr (bpc-switch-suspend) [102.538927] Starting subtest: bpc-switch-suspend [102.541027] Subtest bpc-switch-suspend: SKIP (0.000s) [102.650349] [028/130] (924s left) kms_big_fb (4-tiled-64bpp-rotate-180) [102.761750] Starting subtest: 4-tiled-64bpp-rotate-180 [102.763071] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s) [102.914304] [029/130] (924s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs) [103.020865] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs [103.021560] Starting dynamic subtest: pipe-A-HDMI-A-1 [103.028042] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [103.033443] Starting dynamic subtest: pipe-B-HDMI-A-1 [103.039885] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [103.041194] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.001s) [103.252787] [030/130] (924s left) kms_flip (blocking-absolute-wf_vblank) [103.360491] Starting subtest: blocking-absolute-wf_vblank [103.361271] Starting dynamic subtest: A-HDMI-A1 [118.732189] Dynamic subtest A-HDMI-A1: SUCCESS (15.370s) [118.741171] Starting dynamic subtest: B-HDMI-A1 [134.078985] Dynamic subtest B-HDMI-A1: SUCCESS (15.345s) [134.082704] Subtest blocking-absolute-wf_vblank: SUCCESS (30.720s) [134.313618] [031/130] (893s left) kms_sequence (queue-idle) [134.420876] Starting subtest: queue-idle [134.421571] Starting dynamic subtest: pipe-A-HDMI-A-1 [136.984409] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.562s) [136.991290] Starting dynamic subtest: pipe-B-HDMI-A-1 [139.436422] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.451s) [139.437117] Subtest queue-idle: SUCCESS (5.015s) [139.566840] [032/130] (888s left) kms_plane_cursor (overlay) [139.671959] Starting subtest: overlay [139.673331] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [142.552332] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.879s) [142.636753] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [145.493531] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.865s) [145.578371] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [148.415314] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.845s) [148.523771] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64 [151.282317] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.764s) [151.356277] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128 [154.090378] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.749s) [154.163972] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256 [156.936403] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.789s) [157.020604] Subtest overlay: SUCCESS (17.348s) [157.150389] [033/130] (870s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [157.265072] Starting subtest: fbcpsr-farfromfence-mmap-gtt [157.266438] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [157.418490] [034/130] (870s left) kms_frontbuffer_tracking (fbc-2p-rte) [157.529459] Starting subtest: fbc-2p-rte [157.530778] Subtest fbc-2p-rte: SKIP (0.000s) [157.663454] [035/130] (870s left) gen9_exec_parse (bb-start-out) [157.700731] Subtest bb-start-out: SKIP (0.000s) [157.754785] [036/130] (870s left) gem_ctx_param (set-priority-invalid-size) [157.787439] Starting subtest: set-priority-invalid-size [157.788127] Subtest set-priority-invalid-size: SUCCESS (0.000s) [157.891778] [037/130] (870s left) gem_ctx_param (vm) [157.924305] Starting subtest: vm [157.943114] Subtest vm: SUCCESS (0.019s) [158.091365] [038/130] (869s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [158.195975] Starting subtest: plane-upscale-20x20-with-pixel-format [158.196682] Starting dynamic subtest: pipe-A [160.041371] Dynamic subtest pipe-A: SUCCESS (1.845s) [160.058382] Starting dynamic subtest: pipe-B [161.896638] Dynamic subtest pipe-B: SUCCESS (1.852s) [161.898152] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (3.700s) [162.128527] [039/130] (865s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [162.165564] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [162.271703] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [162.377410] [040/130] (865s left) gem_exec_flush (basic-wb-ro-before-default) [162.420639] Starting subtest: basic-wb-ro-before-default [167.872319] Subtest basic-wb-ro-before-default: SUCCESS (5.452s) [168.121136] [041/130] (860s left) gem_wait (busy) [168.166898] Starting subtest: busy [168.167665] Starting dynamic subtest: all-engines [168.681766] Dynamic subtest all-engines: SUCCESS (0.515s) [168.687951] Starting dynamic subtest: rcs0 [169.193758] Dynamic subtest rcs0: SUCCESS (0.512s) [169.199949] Starting dynamic subtest: bcs0 [169.705740] Dynamic subtest bcs0: SUCCESS (0.512s) [169.711301] Starting dynamic subtest: vcs0 [170.219724] Dynamic subtest vcs0: SUCCESS (0.514s) [170.225274] Starting dynamic subtest: vecs0 [170.733718] Dynamic subtest vecs0: SUCCESS (0.514s) [170.734400] Subtest busy: SUCCESS (2.567s) [170.962399] [042/130] (857s left) gem_pxp (verify-pxp-stale-buf-execution) [351.576555] Per-test timeout exceeded. Killing the current test with SIGQUIT. [361.080354] Closing watchdogs [361.083065] Initializing watchdogs [361.083111] /dev/watchdog0 [361.096688] [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] [361.100883] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [361.102135] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [361.104213] [043/130] (667s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [361.144267] Starting subtest: y-tiled-ccs-to-y-tiled [361.144970] Starting dynamic subtest: smem [361.281849] Dynamic subtest smem: SUCCESS (0.137s) [361.282553] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.138s) [361.477804] [044/130] (666s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render) [361.587762] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render [363.753728] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (2.167s) [363.955280] [045/130] (664s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [364.065051] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [364.065768] Starting dynamic subtest: pipe-A-HDMI-A-1 [364.072374] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [364.078156] Starting dynamic subtest: pipe-B-HDMI-A-1 [364.084682] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [364.085995] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [364.305331] [046/130] (664s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [364.416073] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [364.449740] [047/130] (663s left) gem_exec_reloc (basic-gtt-cpu-active) [364.487317] Subtest basic-gtt-cpu-active: SKIP (0.000s) [364.571539] [048/130] (663s left) kms_chamelium_color (ctm-0-75) [364.680510] Subtest ctm-0-75: SKIP (0.000s) [364.715655] [049/130] (663s left) kms_psr (fbc-psr-primary-render) [364.827520] Subtest fbc-psr-primary-render: SKIP (0.000s) [364.870775] [050/130] (663s left) syncobj_eventfd (timeline-wait) [364.905575] Starting subtest: timeline-wait [364.915839] Subtest timeline-wait: SUCCESS (0.010s) [365.006158] [051/130] (663s left) gem_exec_capture (capture-recoverable) [365.044389] Starting subtest: capture-recoverable [365.045872] Subtest capture-recoverable: SKIP (0.000s) [365.178061] [052/130] (663s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [365.285156] Starting subtest: addfb25-x-tiled-mismatch-legacy [365.285864] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [365.424288] [053/130] (663s left) gem_ctx_exec (basic-invalid-context) [365.458906] Starting subtest: basic-invalid-context [365.460618] Subtest basic-invalid-context: SUCCESS (0.002s) [365.642100] [054/130] (663s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [365.749203] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [365.749971] Starting dynamic subtest: pipe-A-valid-mode [365.804532] Dynamic subtest pipe-A-valid-mode: SKIP (0.053s) [365.806237] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.055s) [365.929938] [055/130] (662s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [366.042577] Starting subtest: fbc-rgb565-draw-blt [368.582232] Subtest fbc-rgb565-draw-blt: SUCCESS (2.540s) [368.775919] [056/130] (659s left) gem_exec_params (invalid-bsd1-flag-on-blt) [368.812218] Starting subtest: invalid-bsd1-flag-on-blt [368.812917] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [368.937531] [057/130] (659s left) gem_exec_whisper (basic-forked-all) [368.979651] Starting subtest: basic-forked-all [371.743964] Subtest basic-forked-all: SUCCESS (2.764s) [371.967617] [058/130] (656s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [372.002200] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [372.002883] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [372.107164] [059/130] (656s left) prime_mmap (test_correct_cpu_write) [372.140546] Starting subtest: test_correct_cpu_write [372.141240] Starting dynamic subtest: test_correct_cpu_write-smem [372.141935] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [372.142599] Subtest test_correct_cpu_write: SUCCESS (0.001s) [372.256119] [060/130] (656s left) syncobj_basic (bad-destroy-pad) [372.289429] Starting subtest: bad-destroy-pad [372.290128] Subtest bad-destroy-pad: SUCCESS (0.000s) [372.389163] [061/130] (656s left) kms_flip (absolute-wf_vblank) [372.497487] Starting subtest: absolute-wf_vblank [372.499104] Starting dynamic subtest: A-HDMI-A1 [387.882132] Dynamic subtest A-HDMI-A1: SUCCESS (15.383s) [387.891778] Starting dynamic subtest: B-HDMI-A1 [403.229778] Dynamic subtest B-HDMI-A1: SUCCESS (15.345s) [403.232193] Subtest absolute-wf_vblank: SUCCESS (30.734s) [403.465886] [062/130] (625s left) kms_psr2_su (page_flip-nv12) [403.500387] Subtest page_flip-NV12: SKIP (0.000s) [403.532888] [063/130] (625s left) kms_lease (lease-get) [403.640033] Starting subtest: lease-get [403.641685] Starting dynamic subtest: pipe-A-HDMI-A-1 [403.642372] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [403.649205] Starting dynamic subtest: pipe-B-HDMI-A-1 [403.649891] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [403.650539] Subtest lease-get: SUCCESS (0.004s) [403.746932] [064/130] (625s left) syncobj_wait (multi-wait-submitted-signaled) [403.781878] Starting subtest: multi-wait-submitted-signaled [403.782561] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [403.881768] [065/130] (625s left) gem_exec_reloc (basic-write-wc-noreloc) [403.917409] Subtest basic-write-wc-noreloc: SKIP (0.000s) [404.020300] [066/130] (625s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [404.127279] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [404.129544] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [404.221612] [067/130] (624s left) kms_psr (psr-sprite-render) [404.329535] Subtest psr-sprite-render: SKIP (0.000s) [404.366731] [068/130] (624s left) kms_plane (plane-panning-top-left) [404.476121] Starting subtest: plane-panning-top-left [404.477779] Starting dynamic subtest: pipe-A [405.085830] Dynamic subtest pipe-A: SUCCESS (0.607s) [405.096358] Starting dynamic subtest: pipe-B [405.546462] Dynamic subtest pipe-B: SUCCESS (0.458s) [405.547301] Subtest plane-panning-top-left: SUCCESS (1.070s) [405.732871] [069/130] (623s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [405.849191] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [405.850558] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [406.000406] [070/130] (623s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [406.110735] Starting subtest: fbcpsr-rgb565-draw-pwrite [406.112026] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s) [406.248519] [071/130] (623s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [406.357177] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s) [406.393543] [072/130] (622s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25) [406.502329] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25 [406.503074] Starting dynamic subtest: pipe-A [406.926567] Dynamic subtest pipe-A: SKIP (0.422s) [406.932499] Starting dynamic subtest: pipe-B [407.552758] Dynamic subtest pipe-B: SKIP (0.625s) [407.554068] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (1.049s) [407.663656] [073/130] (621s left) gem_exec_schedule (implicit-write-read) [407.709797] Starting subtest: implicit-write-read [407.710461] Starting dynamic subtest: rcs0 [407.758260] Dynamic subtest rcs0: SUCCESS (0.048s) [407.765637] Starting dynamic subtest: bcs0 [407.804541] Dynamic subtest bcs0: SUCCESS (0.045s) [407.812061] Starting dynamic subtest: vcs0 [407.850341] Dynamic subtest vcs0: SUCCESS (0.045s) [407.856871] Starting dynamic subtest: vecs0 [407.896048] Dynamic subtest vecs0: SUCCESS (0.045s) [407.896780] Subtest implicit-write-read: SUCCESS (0.187s) [408.195125] [074/130] (621s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [408.302168] Starting subtest: sprite-rotation-90-pos-100-0 [414.862055] Subtest sprite-rotation-90-pos-100-0: SUCCESS (6.559s) [415.096292] [075/130] (614s left) gem_madvise (dontneed-before-pwrite) [415.129796] Starting subtest: dontneed-before-pwrite [415.131974] Subtest dontneed-before-pwrite: SKIP (0.002s) [415.184577] [076/130] (614s left) kms_big_fb (y-tiled-8bpp-rotate-0) [415.299849] Starting subtest: y-tiled-8bpp-rotate-0 [416.810625] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.510s) [416.981356] [077/130] (612s left) fbdev (read) [417.019859] Starting subtest: read [417.623092] Subtest read: SUCCESS (0.603s) [417.703091] [078/130] (611s left) kms_chamelium_color (ctm-0-25) [417.809559] Subtest ctm-0-25: SKIP (0.000s) [417.862288] [079/130] (611s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [417.897297] Starting subtest: multi-wait-all-available-submitted-signaled [417.898009] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s) [418.000462] [080/130] (611s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [418.107382] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [418.109331] Starting dynamic subtest: pipe-A-HDMI-A-1 [418.116553] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [418.122659] Starting dynamic subtest: pipe-B-HDMI-A-1 [418.129829] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [418.131272] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.003s) [418.371068] [081/130] (611s left) gem_render_copy_redux (normal) [418.408604] Starting subtest: normal [418.785579] Subtest normal: SUCCESS (0.377s) [418.934703] [082/130] (610s left) gem_exec_fence (syncobj-import) [419.268595] Starting subtest: syncobj-import [419.270763] Subtest syncobj-import: SUCCESS (0.002s) [419.621099] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true [419.622852] [083/130] (610s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [419.740375] Starting subtest: yf-tiled-16bpp-rotate-90 [419.741755] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [419.851586] [084/130] (609s left) syncobj_timeline (single-wait-for-submit-available-submitted) [419.885727] Starting subtest: single-wait-for-submit-available-submitted [419.886412] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [419.985208] [085/130] (609s left) fbdev (unaligned-write) [420.028070] Starting subtest: unaligned-write [420.136673] Subtest unaligned-write: SUCCESS (0.109s) [420.194165] [086/130] (609s left) gem_mmap_wc (copy) [420.229384] Starting subtest: copy [420.350947] Subtest copy: SUCCESS (0.122s) [420.460117] [087/130] (609s left) kms_writeback (writeback-fb-id) [420.568439] Subtest writeback-fb-id: SKIP (0.000s) [420.605272] [088/130] (609s left) kms_cursor_edge_walk (128x128-right-edge) [420.713438] Starting subtest: 128x128-right-edge [420.715144] Starting dynamic subtest: pipe-A-HDMI-A-1 [424.454879] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.740s) [424.461995] Starting dynamic subtest: pipe-B-HDMI-A-1 [428.096592] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.640s) [428.097277] Subtest 128x128-right-edge: SUCCESS (7.383s) [428.236066] [089/130] (601s left) gem_mmap (big-bo) [428.268718] Starting subtest: big-bo [428.971041] Subtest big-bo: SUCCESS (0.702s) [429.081217] [090/130] (600s left) gem_fence_thrash (bo-write-verify-threaded-none) [429.149366] Starting subtest: bo-write-verify-threaded-none [436.145290] Subtest bo-write-verify-threaded-none: SUCCESS (6.996s) [436.351372] [091/130] (593s left) gem_exec_schedule (preempt-other) [436.406129] Starting subtest: preempt-other [436.406872] Starting dynamic subtest: rcs0 [436.424653] Dynamic subtest rcs0: SUCCESS (0.018s) [436.431186] Starting dynamic subtest: bcs0 [436.441951] Dynamic subtest bcs0: SUCCESS (0.017s) [436.449584] Starting dynamic subtest: vcs0 [436.459876] Dynamic subtest vcs0: SUCCESS (0.017s) [436.467546] Starting dynamic subtest: vecs0 [436.477960] Dynamic subtest vecs0: SUCCESS (0.017s) [436.478735] Subtest preempt-other: SUCCESS (0.072s) [436.819309] [092/130] (593s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [436.932774] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [438.889758] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.957s) [439.076579] [093/130] (591s left) gem_pread (bench) [439.111303] Subtest bench: SKIP (0.000s) [439.165520] [094/130] (591s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [439.280367] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [439.761933] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.481s) [440.007272] [095/130] (590s left) gem_exec_schedule (u-submit-golden-slice) [440.052126] Starting subtest: u-submit-golden-slice [440.052853] Starting dynamic subtest: rcs0 [440.070903] Dynamic subtest rcs0: SUCCESS (0.018s) [440.078954] Starting dynamic subtest: bcs0 [440.089934] Dynamic subtest bcs0: SUCCESS (0.018s) [440.096811] Starting dynamic subtest: vcs0 [440.109876] Dynamic subtest vcs0: SUCCESS (0.019s) [440.117604] Starting dynamic subtest: vecs0 [440.131925] Dynamic subtest vecs0: SUCCESS (0.021s) [440.132752] Subtest u-submit-golden-slice: SUCCESS (0.080s) [440.462798] [096/130] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [440.574694] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [440.576014] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [440.729187] [097/130] (589s left) gem_reg_read (timestamp-monotonic) [440.762095] Starting subtest: timestamp-monotonic [445.407041] Subtest timestamp-monotonic: SUCCESS (4.645s) [445.497740] [098/130] (584s left) gem_softpin (evict-prime-sanity-check) [445.534068] Starting subtest: evict-prime-sanity-check [445.534797] Starting dynamic subtest: rcs0 [446.664753] Dynamic subtest rcs0: SUCCESS (1.130s) [446.675855] Starting dynamic subtest: bcs0 [447.802807] Dynamic subtest bcs0: SUCCESS (1.135s) [447.816438] Starting dynamic subtest: vcs0 [448.933724] Dynamic subtest vcs0: SUCCESS (1.128s) [448.946675] Starting dynamic subtest: vecs0 [450.071052] Dynamic subtest vecs0: SUCCESS (1.134s) [450.090560] Starting dynamic subtest: all [451.219952] Dynamic subtest all: SUCCESS (1.144s) [451.225771] Subtest evict-prime-sanity-check: SUCCESS (5.687s) [451.334145] [099/130] (579s left) syncobj_wait (wait-any-snapshot) [451.369490] Starting subtest: wait-any-snapshot [451.450389] Subtest wait-any-snapshot: SUCCESS (0.081s) [451.556226] [100/130] (578s left) device_reset (unbind-reset-rebind) [451.599656] Starting subtest: unbind-reset-rebind [455.555805] Subtest unbind-reset-rebind: SUCCESS (3.956s) [455.601044] [101/130] (574s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [455.637546] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [455.671621] [102/130] (574s left) api_intel_allocator (reopen) [455.704479] Starting subtest: reopen [455.706273] Subtest reopen: SUCCESS (0.002s) [455.869838] [103/130] (574s left) gem_mmap_wc (bad-object) [455.904538] Starting subtest: bad-object [455.905227] Subtest bad-object: SUCCESS (0.000s) [456.042641] [104/130] (574s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [456.158711] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [456.612383] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.454s) [456.858099] [105/130] (573s left) gem_tiled_fence_blits (basic) [456.954087] Starting subtest: basic [456.995380] Subtest basic: SUCCESS (0.043s) [457.180927] [106/130] (573s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [457.331845] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [457.333195] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [457.484735] [107/130] (573s left) kms_joiner (basic-force-ultra-joiner) [457.592423] Starting subtest: basic-force-ultra-joiner [457.593803] Subtest basic-force-ultra-joiner: SKIP (0.000s) [457.690116] [108/130] (573s left) kms_vblank (query-forked-busy) [457.799228] Starting subtest: query-forked-busy [457.801116] Starting dynamic subtest: pipe-A-HDMI-A-1 [460.615273] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.813s) [460.648509] Starting dynamic subtest: pipe-B-HDMI-A-1 [463.374146] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.743s) [463.375249] Subtest query-forked-busy: SUCCESS (5.567s) [463.595944] [109/130] (567s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-different-formats) [463.921359] Subtest fbc-dirty-rectangle-different-formats: SKIP (0.000s) [464.002562] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-different-formats)] new: kernel.kmod_is_loaded.xe: true [464.004318] [110/130] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu) [464.117386] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu [464.118812] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [464.261213] [111/130] (566s left) kms_pm_rpm (basic-pci-d3-state) [465.713481] Starting subtest: basic-pci-d3-state [466.024942] Subtest basic-pci-d3-state: SUCCESS (0.311s) [466.228829] [112/130] (564s left) kms_psr (pr-sprite-plane-move) [466.337581] Subtest pr-sprite-plane-move: SKIP (0.000s) [466.402326] [113/130] (564s left) kms_chamelium_hpd (hdmi-hpd) [466.565966] Subtest hdmi-hpd: SKIP (0.000s) [466.656389] [114/130] (564s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [466.764686] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [466.766045] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [466.919388] [115/130] (564s left) prime_busy (after) [466.955283] Starting subtest: after [466.960858] Starting dynamic subtest: rcs0 [467.025566] Dynamic subtest rcs0: SUCCESS (0.064s) [467.047991] Starting dynamic subtest: bcs0 [467.079223] Dynamic subtest bcs0: SUCCESS (0.051s) [467.099519] Starting dynamic subtest: vcs0 [467.110834] Dynamic subtest vcs0: SUCCESS (0.029s) [467.123660] Starting dynamic subtest: vecs0 [467.138032] Dynamic subtest vecs0: SUCCESS (0.025s) [467.246921] Subtest after: SUCCESS (0.291s) [467.356473] [116/130] (563s left) gem_gpgpu_fill (basic) [467.392730] Starting subtest: basic [467.393432] Starting dynamic subtest: smem [467.395126] Dynamic subtest smem: SUCCESS (0.003s) [467.395807] Subtest basic: SUCCESS (0.004s) [467.541527] [117/130] (563s left) gem_exec_balancer (bonded-chain) [467.585107] Starting subtest: bonded-chain [468.605716] Subtest bonded-chain: SUCCESS (1.020s) [468.820472] [118/130] (562s left) kms_cursor_crc (cursor-rapid-movement-max-size) [468.936050] Starting subtest: cursor-rapid-movement-max-size [468.938059] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [469.070395] [119/130] (562s left) i915_hangman (gt-error-state-capture) [469.113743] Starting subtest: gt-error-state-capture [469.114428] Starting dynamic subtest: rcs0 [478.979884] Dynamic subtest rcs0: SUCCESS (9.866s) [478.992049] Starting dynamic subtest: bcs0 [488.959806] Dynamic subtest bcs0: SUCCESS (9.977s) [488.973668] Starting dynamic subtest: vcs0 [498.918789] Dynamic subtest vcs0: SUCCESS (9.956s) [498.941313] Starting dynamic subtest: vecs0 [508.905662] Dynamic subtest vecs0: SUCCESS (9.984s) [508.907248] Subtest gt-error-state-capture: SUCCESS (39.794s) [509.021702] [120/130] (522s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [509.194978] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [509.280031] [121/130] (522s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render) [509.391748] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render [509.393068] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [509.528922] [122/130] (521s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [509.639747] Starting subtest: psr-2p-scndscrn-spr-indfb-move [509.641090] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [509.792604] [123/130] (521s left) gem_exec_balancer (nop) [509.833397] Starting subtest: nop [545.489623] Subtest nop: SUCCESS (35.656s) [545.709219] [124/130] (485s left) i915_pm_rpm (reg-read-ioctl) [547.143259] Starting subtest: reg-read-ioctl [547.478075] Subtest reg-read-ioctl: SUCCESS (0.335s) [547.669732] [125/130] (483s left) kms_psr (fbc-pr-sprite-plane-move) [547.776605] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [547.831128] [126/130] (483s left) gem_media_fill (media-fill) [547.871887] Starting subtest: media-fill [547.872693] Starting dynamic subtest: smem [547.874606] Dynamic subtest smem: SUCCESS (0.003s) [547.875304] Subtest media-fill: SUCCESS (0.004s) [548.155672] [127/130] (483s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [548.265766] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [548.267129] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [548.401820] [128/130] (483s left) gem_exec_params (secure-non-root) [548.437139] Starting subtest: secure-non-root [548.438473] Subtest secure-non-root: SKIP (0.000s) [548.591405] [129/130] (483s left) sysfs_heartbeat_interval (nopreempt) [548.627425] Starting subtest: nopreempt [548.629153] Starting dynamic subtest: vecs0 [552.327343] Dynamic subtest vecs0: SUCCESS (3.696s) [552.338436] Starting dynamic subtest: vcs0 [556.001879] Dynamic subtest vcs0: SUCCESS (3.671s) [556.013358] Starting dynamic subtest: bcs0 [559.635453] Dynamic subtest bcs0: SUCCESS (3.631s) [559.642756] Starting dynamic subtest: rcs0 [563.314397] Dynamic subtest rcs0: SUCCESS (3.676s) [563.315651] Subtest nopreempt: SUCCESS (14.685s) [563.414535] [130/130] (468s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [563.524548] Starting subtest: cursorA-vs-flipA-varying-size [574.367143] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.842s) [574.552883] Closing watchdogs Done.