[59.255342] Initializing watchdogs [59.255388] /dev/watchdog0 [59.269492] [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] [59.273158] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.275246] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.278491] [001/130] (960s left) intel_hwmon (hwmon-read) [59.395102] Subtest hwmon-read: SKIP (0.000s) [59.440439] [002/130] (960s left) syncobj_timeline (transfer-timeline-point) [59.501703] Starting subtest: transfer-timeline-point [59.504076] Subtest transfer-timeline-point: SUCCESS (0.000s) [59.595211] [003/130] (960s left) gem_tiled_swapping (non-threaded) [59.652861] Subtest non-threaded: SKIP (0.000s) [59.697041] [004/130] (960s left) syncobj_timeline (multi-wait-all-signaled) [59.755229] Starting subtest: multi-wait-all-signaled [59.757465] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [59.869822] [005/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [59.968541] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [59.972302] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [60.077286] [006/130] (959s left) kms_psr (psr2-primary-render) [60.181894] Starting subtest: psr2-primary-render [60.183819] Starting dynamic subtest: eDP-1 [61.947304] Dynamic subtest eDP-1: SUCCESS (1.763s) [61.949421] Subtest psr2-primary-render: SUCCESS (1.763s) [62.806487] [007/130] (957s left) kms_atomic_transition (modeset-transition-fencing) [62.908430] Starting subtest: modeset-transition-fencing [62.910871] Starting dynamic subtest: 1x-outputs [73.438999] Dynamic subtest 1x-outputs: SUCCESS (10.529s) [73.705537] Subtest modeset-transition-fencing: SUCCESS (10.796s) [74.560662] [008/130] (945s left) gem_create (create-ext-cpu-access-big) [74.738322] Starting subtest: create-ext-cpu-access-big [74.743174] Subtest create-ext-cpu-access-big: SKIP (0.001s) [74.803563] [009/130] (945s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [79.813152] Starting subtest: psr2-plane-move-sf-dmg-area [79.815179] Starting dynamic subtest: pipe-A-eDP-1 [84.995961] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.183s) [85.004443] Starting dynamic subtest: pipe-B-eDP-1 [90.195134] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.197s) [90.197715] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.383s) [91.062535] [010/130] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [91.164468] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [95.951863] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.790s) [96.099992] [011/130] (923s left) syncobj_eventfd (timeline-wait-before-signal) [96.153834] Starting subtest: timeline-wait-before-signal [96.183445] Subtest timeline-wait-before-signal: SUCCESS (0.031s) [96.245864] [012/130] (923s left) kms_color (invalid-degamma-lut-sizes) [96.352892] Starting subtest: invalid-degamma-lut-sizes [96.355281] Starting dynamic subtest: pipe-A [96.637383] Dynamic subtest pipe-A: SUCCESS (0.282s) [96.645292] Starting dynamic subtest: pipe-B [96.647589] Dynamic subtest pipe-B: SUCCESS (0.001s) [96.654539] Starting dynamic subtest: pipe-C [96.656861] Dynamic subtest pipe-C: SUCCESS (0.001s) [96.663632] Starting dynamic subtest: pipe-D [96.665905] Dynamic subtest pipe-D: SUCCESS (0.001s) [96.668188] Subtest invalid-degamma-lut-sizes: SUCCESS (0.285s) [97.444045] [013/130] (922s left) kms_lease (lessee-list) [97.549043] Starting subtest: lessee-list [97.551673] Starting dynamic subtest: pipe-A-eDP-1 [97.554083] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [97.561552] Starting dynamic subtest: pipe-B-eDP-1 [97.563834] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [97.570095] Starting dynamic subtest: pipe-C-eDP-1 [97.572360] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [97.578566] Starting dynamic subtest: pipe-D-eDP-1 [97.580822] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [97.583037] Subtest lessee-list: SUCCESS (0.007s) [97.660499] [014/130] (922s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [97.757575] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [97.759852] Starting dynamic subtest: pipe-A-eDP-1 [97.782133] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [97.790657] Starting dynamic subtest: pipe-B-eDP-1 [97.811364] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [97.817948] Starting dynamic subtest: pipe-C-eDP-1 [97.838518] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [97.844999] Starting dynamic subtest: pipe-D-eDP-1 [97.866793] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [97.871156] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [99.904952] [015/130] (920s left) kms_rotation_crc (cursor-rotation-180) [100.012879] Starting subtest: cursor-rotation-180 [101.446490] Subtest cursor-rotation-180: SUCCESS (1.433s) [102.648088] [016/130] (917s left) kms_hdr (bpc-switch) [102.740080] Starting subtest: bpc-switch [103.826781] Starting dynamic subtest: pipe-A-eDP-1 [107.111136] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.284s) [107.113572] Subtest bpc-switch: SUCCESS (4.370s) [107.240807] [017/130] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [107.344598] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [107.349096] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [107.437369] [018/130] (912s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [107.503931] Starting subtest: single-wait-all-for-submit-available-submitted [107.506185] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [107.589246] [019/130] (912s left) kms_psr (fbc-pr-cursor-mmap-gtt) [107.679830] Starting subtest: fbc-pr-cursor-mmap-gtt [107.684292] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [107.742423] [020/130] (912s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [107.847191] Starting subtest: fbc-rgb565-draw-mmap-gtt [107.851163] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [107.951031] [021/130] (912s left) gem_mmap_wc (bad-offset) [108.011324] Subtest bad-offset: SKIP (0.000s) [108.066033] [022/130] (912s left) kms_big_fb (x-tiled-32bpp-rotate-270) [108.175373] Starting subtest: x-tiled-32bpp-rotate-270 [108.193274] Subtest x-tiled-32bpp-rotate-270: SKIP (0.018s) [108.318122] [023/130] (912s left) kms_atomic (crtc-invalid-params-fence) [108.401461] Starting subtest: crtc-invalid-params-fence [108.403375] Starting dynamic subtest: pipe-A-eDP-1 [108.794582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.391s) [108.797068] Subtest crtc-invalid-params-fence: SUCCESS (0.392s) [109.581927] [024/130] (910s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [109.698182] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [110.921451] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.225s) [111.118375] [025/130] (909s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [111.243342] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [112.211954] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.967s) [113.001079] [026/130] (907s left) syncobj_wait (multi-wait-submitted-signaled) [113.064235] Starting subtest: multi-wait-submitted-signaled [113.066555] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [113.155296] [027/130] (907s left) gem_create (create-ext-placement-all) [113.329822] Starting subtest: create-ext-placement-all [113.332810] Subtest create-ext-placement-all: SUCCESS (0.000s) [113.438068] [028/130] (907s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [113.539936] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [113.551785] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s) [113.614927] [029/130] (907s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [113.715405] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [118.853990] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.142s) [118.984275] [030/130] (901s left) kms_flip (2x-plain-flip-interruptible) [119.088337] Starting subtest: 2x-plain-flip-interruptible [119.100427] Subtest 2x-plain-flip-interruptible: SKIP (0.010s) [119.191237] [031/130] (901s left) kms_psr (psr-sprite-mmap-cpu) [119.283311] Starting subtest: psr-sprite-mmap-cpu [119.285547] Starting dynamic subtest: eDP-1 [120.962941] Dynamic subtest eDP-1: SUCCESS (1.678s) [120.965561] Subtest psr-sprite-mmap-cpu: SUCCESS (1.678s) [121.793815] [032/130] (898s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [121.923627] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [122.053938] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.134s) [122.165469] [033/130] (898s left) gem_flink_race (flink_name) [122.201079] Starting subtest: flink_name [127.597122] Subtest flink_name: SUCCESS (5.391s) [127.690622] [034/130] (893s left) gem_exec_params (dr1-dirt) [127.750604] Starting subtest: DR1-dirt [127.752982] Subtest DR1-dirt: SUCCESS (0.000s) [127.851198] [035/130] (892s left) gem_softpin (allocator-nopin-reserve) [127.915520] Starting subtest: allocator-nopin-reserve [128.009576] Subtest allocator-nopin-reserve: SUCCESS (0.094s) [128.143620] [036/130] (892s left) i915_power (sanity) [128.198342] Starting subtest: sanity [132.245451] Subtest sanity: SUCCESS (4.041s) [133.950980] [037/130] (886s left) gem_userptr_blits (map-fixed-invalidate-busy) [134.018338] Starting subtest: map-fixed-invalidate-busy [134.022788] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [134.132947] [038/130] (886s left) kms_invalid_mode (zero-clock) [134.233203] Starting subtest: zero-clock [134.235346] Starting dynamic subtest: pipe-A-eDP-1 [134.513394] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s) [134.521919] Starting dynamic subtest: pipe-B-eDP-1 [134.523905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [134.530355] Starting dynamic subtest: pipe-C-eDP-1 [134.532332] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [134.539101] Starting dynamic subtest: pipe-D-eDP-1 [134.541411] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [134.543695] Subtest zero-clock: SUCCESS (0.286s) [135.316729] [039/130] (885s left) kms_chamelium_audio (hdmi-audio) [135.706792] Subtest hdmi-audio: SKIP (0.000s) [136.519700] [040/130] (884s left) gem_exec_fence (submit3) [136.693760] Starting subtest: submit3 [136.698722] Subtest submit3: SKIP (0.000s) [139.004759] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [139.007968] [041/130] (882s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [139.064475] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [139.109270] [042/130] (881s left) gem_mmap_wc (close) [139.167256] Subtest close: SKIP (0.000s) [139.220824] [043/130] (881s left) gem_exec_params (invalid-fence-in-submit) [139.281369] Starting subtest: invalid-fence-in-submit [139.290913] Subtest invalid-fence-in-submit: SUCCESS (0.007s) [139.433828] [044/130] (881s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [139.538087] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [139.540309] Starting dynamic subtest: pipe-A-eDP-1 [139.779292] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.208s) [139.785973] Starting dynamic subtest: pipe-B-eDP-1 [141.007068] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.225s) [141.014114] Starting dynamic subtest: pipe-C-eDP-1 [142.208164] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s) [142.217632] Starting dynamic subtest: pipe-D-eDP-1 [143.435030] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s) [143.437130] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.864s) [144.555463] [045/130] (876s left) gem_userptr_blits (process-exit-busy) [144.628774] Starting subtest: process-exit-busy [144.643497] Subtest process-exit-busy: SUCCESS (0.015s) [144.780322] [046/130] (876s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [145.184123] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [145.960521] [047/130] (875s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [146.079602] Starting subtest: fbc-rgb101010-draw-render [149.677125] Subtest fbc-rgb101010-draw-render: SUCCESS (3.601s) [149.792087] [048/130] (871s left) gem_exec_reloc (basic-gtt-read-active) [149.857801] Subtest basic-gtt-read-active: SKIP (0.000s) [149.932406] [049/130] (871s left) vgem_basic (setversion) [149.971491] Starting subtest: setversion [149.976020] Subtest setversion: SUCCESS (0.000s) [150.019361] [050/130] (871s left) gem_mmap_wc (write) [150.073396] Subtest write: SKIP (0.000s) [150.129828] [051/130] (871s left) kms_cursor_edge_walk (128x128-top-bottom) [150.222975] Starting subtest: 128x128-top-bottom [150.225312] Starting dynamic subtest: pipe-A-eDP-1 [153.661950] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s) [153.669138] Starting dynamic subtest: pipe-D-eDP-1 [156.764389] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.101s) [156.766784] Subtest 128x128-top-bottom: SUCCESS (6.540s) [157.581344] [052/130] (863s left) gem_exec_balancer (bonded-true-hang) [157.824900] Starting subtest: bonded-true-hang [157.829750] Subtest bonded-true-hang: SKIP (0.000s) [157.932484] [053/130] (863s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [157.984653] Starting subtest: y-tiled-ccs-to-y-tiled [157.989320] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [158.161635] [054/130] (863s left) kms_flip (2x-flip-vs-dpms) [158.256435] Starting subtest: 2x-flip-vs-dpms [158.267080] Subtest 2x-flip-vs-dpms: SKIP (0.010s) [158.343375] [055/130] (863s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [163.321472] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [163.326359] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [164.175667] [056/130] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [164.272418] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [164.276855] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [164.378304] [057/130] (857s left) gem_sync (basic-store-each) [164.458269] Starting subtest: basic-store-each [166.775724] Subtest basic-store-each: SUCCESS (2.328s) [166.962526] [058/130] (854s left) kms_plane_scaling (planes-downscale-factor-0-5) [167.064752] Starting subtest: planes-downscale-factor-0-5 [167.067066] Starting dynamic subtest: pipe-A [167.075879] Dynamic subtest pipe-A: SKIP (0.005s) [167.083396] Starting dynamic subtest: pipe-B [167.092248] Dynamic subtest pipe-B: SKIP (0.015s) [167.101330] Starting dynamic subtest: pipe-C [167.110943] Dynamic subtest pipe-C: SKIP (0.016s) [167.118464] Starting dynamic subtest: pipe-D [167.127526] Dynamic subtest pipe-D: SKIP (0.015s) [167.132018] Subtest planes-downscale-factor-0-5: SKIP (0.052s) [167.230739] [059/130] (854s left) kms_sequence (queue-idle) [167.331066] Starting subtest: queue-idle [167.333413] Starting dynamic subtest: pipe-A-eDP-1 [169.133794] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.800s) [169.143653] Starting dynamic subtest: pipe-B-eDP-1 [171.643173] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.508s) [171.652507] Starting dynamic subtest: pipe-C-eDP-1 [174.047868] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.404s) [174.056192] Starting dynamic subtest: pipe-D-eDP-1 [176.470512] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.421s) [176.472905] Subtest queue-idle: SUCCESS (9.137s) [177.272866] [060/130] (844s left) kms_vblank (wait-busy) [177.367130] Starting subtest: wait-busy [177.369480] Starting dynamic subtest: pipe-A-eDP-1 [179.244466] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [179.256424] Starting dynamic subtest: pipe-D-eDP-1 [181.824511] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.578s) [181.826953] Subtest wait-busy: SUCCESS (4.456s) [182.614342] [061/130] (839s left) perf (gen12-unprivileged-single-ctx-counters) [182.723464] Starting subtest: gen12-unprivileged-single-ctx-counters [182.725731] Starting dynamic subtest: rcs0 [182.775190] Dynamic subtest rcs0: SUCCESS (0.051s) [182.777545] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.052s) [182.817939] [062/130] (838s left) gem_linear_blits (basic) [183.223565] Starting subtest: basic [183.232102] Subtest basic: SUCCESS (0.008s) [183.372995] [063/130] (838s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [183.516194] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [183.520397] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [183.597200] [064/130] (838s left) gem_userptr_blits (readonly-pwrite-unsync) [183.670168] Subtest readonly-pwrite-unsync: SKIP (0.000s) [183.786894] [065/130] (838s left) kms_plane_multiple (tiling-yf) [183.889128] Starting subtest: tiling-yf [183.893648] Subtest tiling-yf: SKIP (0.000s) [183.960030] [066/130] (837s left) kms_atomic_transition (plane-all-transition) [184.064438] Starting subtest: plane-all-transition [184.066826] Starting dynamic subtest: pipe-A-eDP-1 [186.569438] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s) [186.855970] Starting dynamic subtest: pipe-B-eDP-1 [190.049332] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.199s) [190.323986] Subtest plane-all-transition: SUCCESS (6.258s) [191.157137] [067/130] (830s left) gem_lmem_swapping (parallel-random-engines) [191.205473] Subtest parallel-random-engines: SKIP (0.000s) [191.242184] [068/130] (830s left) gem_exec_balancer (parallel-balancer) [191.483926] Starting subtest: parallel-balancer [192.210468] Subtest parallel-balancer: SUCCESS (0.725s) [192.322927] [069/130] (829s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [192.438345] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [192.442416] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [192.555365] [070/130] (829s left) kms_chamelium_edid (dp-mode-timings) [192.941629] Subtest dp-mode-timings: SKIP (0.000s) [193.757743] [071/130] (828s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [193.857159] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [193.859416] Starting dynamic subtest: pipe-A-eDP-1 [193.881840] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [193.890831] Starting dynamic subtest: pipe-B-eDP-1 [193.912639] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [193.920654] Starting dynamic subtest: pipe-C-eDP-1 [193.941771] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [193.950069] Starting dynamic subtest: pipe-D-eDP-1 [193.974394] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [193.978721] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [196.022707] [072/130] (826s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [196.124505] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [196.128662] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [196.204534] [073/130] (825s left) sysfs_preempt_timeout (idempotent) [196.261779] Starting subtest: idempotent [196.264158] Starting dynamic subtest: vecs0 [196.266515] Dynamic subtest vecs0: SUCCESS (0.000s) [196.275534] Starting dynamic subtest: ccs0 [196.277443] Dynamic subtest ccs0: SUCCESS (0.000s) [196.285064] Starting dynamic subtest: vcs0 [196.286941] Dynamic subtest vcs0: SUCCESS (0.001s) [196.294108] Starting dynamic subtest: bcs0 [196.295977] Dynamic subtest bcs0: SUCCESS (0.000s) [196.302870] Starting dynamic subtest: rcs0 [196.304789] Dynamic subtest rcs0: SUCCESS (0.000s) [196.311607] Starting dynamic subtest: vcs1 [196.313534] Dynamic subtest vcs1: SUCCESS (0.000s) [196.315475] Subtest idempotent: SUCCESS (0.006s) [196.388373] [074/130] (825s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [196.503686] Starting subtest: fbcpsr-slowdraw [219.473950] Subtest fbcpsr-slowdraw: SUCCESS (22.973s) [219.601091] [075/130] (802s left) gem_exec_fence (submit67) [219.785251] Starting subtest: submit67 [219.789860] Subtest submit67: SKIP (0.000s) [221.997665] [076/130] (800s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [222.101629] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [226.588773] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.489s) [226.696601] [077/130] (795s left) gem_exec_whisper (basic-fds-priority) [226.757020] Starting subtest: basic-fds-priority [250.372960] Subtest basic-fds-priority: SUCCESS (23.612s) [250.551384] [078/130] (771s left) gem_basic (create-close) [250.606861] Starting subtest: create-close [250.611380] Subtest create-close: SUCCESS (0.000s) [250.710363] [079/130] (771s left) fbdev (pan) [250.747551] Starting subtest: pan [250.779726] Subtest pan: SUCCESS (0.034s) [250.843379] [080/130] (771s left) gem_ctx_isolation (preservation-s3) [250.907400] Starting subtest: preservation-S3 [250.909739] Starting dynamic subtest: rcs0 [267.371975] Dynamic subtest rcs0: SUCCESS (1.581s) [267.383594] Starting dynamic subtest: bcs0 [283.248492] Dynamic subtest bcs0: SUCCESS (1.358s) [283.260075] Starting dynamic subtest: vcs0 [299.280457] Dynamic subtest vcs0: SUCCESS (3.150s) [299.292021] Starting dynamic subtest: vcs1 [317.343167] Dynamic subtest vcs1: SUCCESS (5.074s) [317.354560] Starting dynamic subtest: vecs0 [335.332594] Dynamic subtest vecs0: SUCCESS (4.978s) [335.352648] Starting dynamic subtest: ccs0 [353.258101] Dynamic subtest ccs0: SUCCESS (3.181s) [353.260745] Subtest preservation-S3: SUCCESS (19.326s) [353.490211] [081/130] (751s left) kms_busy (extended-modeset-hang-oldfb) [353.594192] Starting subtest: extended-modeset-hang-oldfb [353.597017] Starting dynamic subtest: pipe-A [365.565383] Dynamic subtest pipe-A: SUCCESS (11.958s) [365.575376] Starting dynamic subtest: pipe-D [377.922094] Dynamic subtest pipe-D: SUCCESS (12.352s) [377.924789] Subtest extended-modeset-hang-oldfb: SUCCESS (24.313s) [378.704315] [082/130] (726s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [378.775227] Starting subtest: mixed-tiled-to-y-tiled-ccs [378.780586] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [378.957970] [083/130] (726s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [379.071178] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [379.076499] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [379.206658] [084/130] (726s left) gem_wait (write-wait) [379.276578] Starting subtest: write-wait [379.279511] Starting dynamic subtest: all-engines [380.396946] Dynamic subtest all-engines: SUCCESS (1.120s) [380.414550] Starting dynamic subtest: rcs0 [381.462917] Dynamic subtest rcs0: SUCCESS (1.064s) [381.478929] Starting dynamic subtest: bcs0 [382.530487] Dynamic subtest bcs0: SUCCESS (1.065s) [382.546918] Starting dynamic subtest: vcs0 [383.590490] Dynamic subtest vcs0: SUCCESS (1.058s) [383.607021] Starting dynamic subtest: vcs1 [384.645562] Dynamic subtest vcs1: SUCCESS (1.053s) [384.660202] Starting dynamic subtest: vecs0 [385.702475] Dynamic subtest vecs0: SUCCESS (1.055s) [385.717995] Starting dynamic subtest: ccs0 [386.760757] Dynamic subtest ccs0: SUCCESS (1.056s) [386.763678] Subtest write-wait: SUCCESS (7.483s) [386.952982] [085/130] (718s left) kms_psr (pr-cursor-plane-move) [387.060119] Starting subtest: pr-cursor-plane-move [387.065152] Subtest pr-cursor-plane-move: SKIP (0.000s) [387.125903] [086/130] (718s left) gem_exec_schedule (semaphore-power) [387.321975] Subtest semaphore-power: SKIP (0.000s) [387.492649] [087/130] (718s left) gem_ctx_persistence (legacy-engines-persistence) [387.551910] Starting subtest: legacy-engines-persistence [387.554334] Starting dynamic subtest: render [388.364842] Dynamic subtest render: SUCCESS (0.812s) [388.377231] Starting dynamic subtest: bsd1 [389.192721] Dynamic subtest bsd1: SUCCESS (0.825s) [389.205637] Starting dynamic subtest: bsd2 [389.962792] Dynamic subtest bsd2: SUCCESS (0.767s) [389.975654] Starting dynamic subtest: blt [390.778680] Dynamic subtest blt: SUCCESS (0.813s) [390.791190] Starting dynamic subtest: vebox [391.523723] Dynamic subtest vebox: SUCCESS (0.743s) [391.526649] Subtest legacy-engines-persistence: SUCCESS (3.971s) [391.632637] [088/130] (714s left) gem_userptr_blits (huge-split) [391.700648] Starting subtest: huge-split [391.714383] Subtest huge-split: SUCCESS (0.013s) [391.844636] [089/130] (713s left) gem_exec_schedule (semaphore-user) [391.920833] Starting subtest: semaphore-user [391.969999] Subtest semaphore-user: SUCCESS (0.060s) [394.010423] [090/130] (711s left) kms_flip (2x-absolute-wf_vblank-interruptible) [394.132229] Starting subtest: 2x-absolute-wf_vblank-interruptible [394.143745] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s) [394.217910] [091/130] (711s left) kms_psr (fbc-psr2-sprite-blt) [394.333329] Starting subtest: fbc-psr2-sprite-blt [394.335664] Starting dynamic subtest: eDP-1 [394.340525] Dynamic subtest eDP-1: SKIP (0.000s) [394.345317] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [394.398880] [092/130] (711s left) gem_eio (in-flight-external) [394.595409] Starting subtest: in-flight-external [396.017207] Subtest in-flight-external: SUCCESS (1.420s) [396.183943] [093/130] (709s left) syncobj_timeline (invalid-query-illegal-handle) [396.239363] Starting subtest: invalid-query-illegal-handle [396.242034] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [396.352566] [094/130] (709s left) i915_hangman (error-state-basic) [396.426734] Starting subtest: error-state-basic [396.532433] Subtest error-state-basic: SUCCESS (0.105s) [396.603956] [095/130] (709s left) gen3_render_tiledy_blits [396.710883] [096/130] (709s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [396.834752] Starting subtest: basic-flip-before-cursor-varying-size [397.749820] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.916s) [398.544871] [097/130] (707s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [398.652235] Starting subtest: psr-rgb565-draw-render [403.534080] Subtest psr-rgb565-draw-render: SUCCESS (4.885s) [403.666882] [098/130] (702s left) api_intel_bb (full-batch) [403.739682] Starting subtest: full-batch [403.742479] Subtest full-batch: SUCCESS (0.006s) [403.854488] [099/130] (702s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [403.963333] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [403.968235] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [404.072385] [100/130] (702s left) kms_draw_crc (draw-method-mmap-gtt) [404.169743] Starting subtest: draw-method-mmap-gtt [404.174489] Subtest draw-method-mmap-gtt: SKIP (0.000s) [404.275115] [101/130] (701s left) kms_addfb_basic (too-high) [404.376986] Starting subtest: too-high [404.379588] Subtest too-high: SUCCESS (0.000s) [404.470770] [102/130] (701s left) drm_fdinfo (all-busy-idle-check-all) [404.516690] Starting subtest: all-busy-idle-check-all [404.520191] Subtest all-busy-idle-check-all: SKIP (0.004s) [404.583620] [103/130] (701s left) kms_big_fb (linear-32bpp-rotate-270) [404.708361] Starting subtest: linear-32bpp-rotate-270 [404.728274] Subtest linear-32bpp-rotate-270: SKIP (0.019s) [404.852897] [104/130] (701s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [404.956786] Starting subtest: primary-y-tiled-reflect-x-0 [405.018687] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s) [405.114790] [105/130] (701s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [405.219074] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [405.223009] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [405.315579] [106/130] (701s left) kms_vblank (query-idle) [405.418383] Starting subtest: query-idle [405.421176] Starting dynamic subtest: pipe-A-eDP-1 [407.174315] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s) [407.190968] Starting dynamic subtest: pipe-D-eDP-1 [409.631396] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.454s) [409.633948] Subtest query-idle: SUCCESS (4.209s) [410.463980] [107/130] (695s left) gen9_exec_parse (bb-start-far) [410.533063] Subtest bb-start-far: SKIP (0.000s) [410.587094] [108/130] (695s left) prime_busy (hang-wait) [410.642317] Starting subtest: hang-wait [410.645218] Starting dynamic subtest: rcs0 [436.436228] Dynamic subtest rcs0: SUCCESS (25.780s) [436.446161] Starting dynamic subtest: bcs0 [443.523352] Dynamic subtest bcs0: SUCCESS (7.084s) [443.534053] Starting dynamic subtest: vcs0 [450.563637] Dynamic subtest vcs0: SUCCESS (7.038s) [450.573428] Starting dynamic subtest: vcs1 [457.544125] Dynamic subtest vcs1: SUCCESS (6.975s) [457.553379] Starting dynamic subtest: vecs0 [464.581524] Dynamic subtest vecs0: SUCCESS (7.034s) [464.592512] Starting dynamic subtest: ccs0 [478.425130] Dynamic subtest ccs0: SUCCESS (13.837s) [478.427936] Subtest hang-wait: SUCCESS (67.758s) [478.572832] [109/130] (627s left) gem_exec_flush (basic-uc-pro-default) [478.638956] Starting subtest: basic-uc-pro-default [484.121670] Subtest basic-uc-pro-default: SUCCESS (5.481s) [484.310321] [110/130] (622s left) gem_exec_reloc (basic-wc-cpu-noreloc) [484.376657] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [484.457948] [111/130] (622s left) kms_pm_rpm (fences) [486.003339] Starting subtest: fences [486.009281] Subtest fences: SKIP (0.000s) [486.698162] [112/130] (619s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [486.793987] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [486.796256] Starting dynamic subtest: pipe-A-default-mode [489.497319] Dynamic subtest pipe-A-default-mode: SUCCESS (2.699s) [489.500242] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.700s) [490.363891] [113/130] (616s left) kms_cursor_crc (cursor-random-128x128) [490.552190] Starting subtest: cursor-random-128x128 [490.554965] Starting dynamic subtest: pipe-A-eDP-1 [494.266130] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.707s) [494.295334] Starting dynamic subtest: pipe-D-eDP-1 [498.602077] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.310s) [498.605180] Subtest cursor-random-128x128: SUCCESS (8.045s) [499.421540] [114/130] (607s left) kms_cursor_crc (cursor-sliding-64x21) [499.601138] Starting subtest: cursor-sliding-64x21 [499.642257] Subtest cursor-sliding-64x21: SKIP (0.037s) [499.896748] [115/130] (606s left) kms_plane_lowres (tiling-y) [499.997032] Starting subtest: tiling-y [500.002354] Subtest tiling-y: SKIP (0.000s) [500.065678] [116/130] (606s left) sw_sync (sync_multi_consumer_producer) [500.105917] Starting subtest: sync_multi_consumer_producer [500.614638] Subtest sync_multi_consumer_producer: SUCCESS (0.510s) [500.681400] [117/130] (606s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [500.796366] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [503.492926] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.702s) [503.637453] [118/130] (603s left) perf_pmu (faulting-read) [503.681764] Starting subtest: faulting-read [503.683659] Starting dynamic subtest: wb [503.685850] Dynamic subtest wb: SUCCESS (0.001s) [503.694520] Starting dynamic subtest: wc [503.696583] Dynamic subtest wc: SUCCESS (0.000s) [503.705591] Starting dynamic subtest: uc [503.708039] Dynamic subtest uc: SUCCESS (0.000s) [503.710284] Subtest faulting-read: SUCCESS (0.003s) [503.802665] [119/130] (603s left) i915_query (query-garbage) [503.860158] Starting subtest: query-garbage [503.862367] Subtest query-garbage: SUCCESS (0.000s) [503.949497] [120/130] (602s left) kms_cursor_crc (cursor-offscreen-32x32) [504.078530] Starting subtest: cursor-offscreen-32x32 [504.107965] Subtest cursor-offscreen-32x32: SKIP (0.033s) [504.379445] [121/130] (602s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [504.478369] Starting subtest: extended-pageflip-modeset-hang-oldfb [504.480932] Starting dynamic subtest: pipe-A [512.397633] Dynamic subtest pipe-A: SUCCESS (7.911s) [512.408911] Starting dynamic subtest: pipe-D [520.954876] Dynamic subtest pipe-D: SUCCESS (8.554s) [520.957790] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.469s) [521.803538] [122/130] (585s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [521.910176] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [521.914915] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [522.013751] [123/130] (585s left) api_intel_bb (object-reloc-purge-cache) [522.064634] Starting subtest: object-reloc-purge-cache [522.069617] Subtest object-reloc-purge-cache: SKIP (0.003s) [522.185761] [124/130] (584s left) gem_exec_params (invalid-ring2) [522.239193] Starting subtest: invalid-ring2 [522.242190] Subtest invalid-ring2: SUCCESS (0.000s) [522.339008] [125/130] (584s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [522.460900] Starting subtest: cursorA-vs-flipA-legacy [533.612039] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.149s) [534.428973] [126/130] (572s left) kms_pm_dc (dc3co-vpb-simulation) [535.544499] Starting subtest: dc3co-vpb-simulation [544.940869] Subtest dc3co-vpb-simulation: SKIP (9.391s) [545.077068] [127/130] (562s left) kms_flip (flip-vs-expired-vblank) [545.181317] Starting subtest: flip-vs-expired-vblank [545.184178] Starting dynamic subtest: A-eDP1 [553.837172] Dynamic subtest A-eDP1: SUCCESS (8.653s) [553.847145] Starting dynamic subtest: B-eDP1 [562.563683] Dynamic subtest B-eDP1: SUCCESS (8.722s) [562.574358] Starting dynamic subtest: C-eDP1 [571.279154] Dynamic subtest C-eDP1: SUCCESS (8.711s) [571.290107] Starting dynamic subtest: D-eDP1 [580.007693] Dynamic subtest D-eDP1: SUCCESS (8.725s) [580.013193] Subtest flip-vs-expired-vblank: SUCCESS (34.822s) [581.175924] [128/130] (526s left) kms_big_fb (y-tiled-8bpp-rotate-180) [581.276122] Starting subtest: y-tiled-8bpp-rotate-180 [581.282168] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [581.381175] [129/130] (525s left) gem_mmap (bad-offset) [581.447961] Subtest bad-offset: SKIP (0.000s) [581.518637] [130/130] (525s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [581.613918] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [581.616394] Starting dynamic subtest: pipe-A-default-mode [581.913002] Dynamic subtest pipe-A-default-mode: SKIP (0.295s) [581.918326] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.296s) [582.704382] Closing watchdogs Done.