[62.044789] Initializing watchdogs [62.044838] /dev/watchdog0 [62.060173] [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] [62.064261] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.066759] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.070220] [001/131] (960s left) perf (buffer-fill) [62.253113] Starting subtest: buffer-fill [62.255086] Starting dynamic subtest: 0-rcs0 [64.546065] Dynamic subtest 0-rcs0: SUCCESS (2.274s) [64.552467] Starting dynamic subtest: 1-vcs0 [69.003236] Dynamic subtest 1-vcs0: SUCCESS (4.434s) [69.006082] Subtest buffer-fill: SUCCESS (6.709s) [69.044113] [002/131] (953s left) gem_exec_fence (invalid-timeline-fence-array) [69.606483] Starting subtest: invalid-timeline-fence-array [69.612061] Subtest invalid-timeline-fence-array: SUCCESS (0.007s) [71.092216] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [71.097110] [003/131] (951s left) gem_ctx_shared (disjoint-timelines) [71.211437] Starting subtest: disjoint-timelines [71.242972] Subtest disjoint-timelines: SUCCESS (0.032s) [71.633596] [004/131] (951s left) kms_vblank (ts-continuation-modeset-hang) [71.764057] Starting subtest: ts-continuation-modeset-hang [71.766527] Starting dynamic subtest: pipe-A-eDP-1 [98.727109] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.937s) [98.740229] Starting dynamic subtest: pipe-D-eDP-1 [123.700891] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.966s) [123.702885] Subtest ts-continuation-modeset-hang: SUCCESS (51.907s) [124.496652] [005/131] (898s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [124.615052] Starting subtest: fbc-rgb101010-draw-mmap-cpu [128.158841] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.546s) [128.270499] [006/131] (894s left) gem_render_copy (y-tiled) [128.332798] Starting subtest: y-tiled [128.337527] Subtest y-tiled: SKIP (0.000s) [128.512315] [007/131] (894s left) gem_partial_pwrite_pread (write) [128.577429] Subtest write: SKIP (0.000s) [128.653760] [008/131] (894s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [128.755904] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [128.758302] Starting dynamic subtest: pipe-A-eDP-1 [128.972067] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.204s) [128.981320] Starting dynamic subtest: pipe-B-eDP-1 [129.002868] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [129.011131] Starting dynamic subtest: pipe-C-eDP-1 [129.031311] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [129.037963] Starting dynamic subtest: pipe-D-eDP-1 [129.058501] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [129.060779] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.210s) [131.177334] [009/131] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [131.294280] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [131.298428] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [131.391876] [010/131] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [131.499952] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [131.504658] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [131.597586] [011/131] (891s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [131.698220] Starting subtest: 2x-flip-vs-absolute-wf_vblank [131.709444] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [131.806086] [012/131] (891s left) kms_psr (fbc-psr2-sprite-plane-move) [131.906149] Starting subtest: fbc-psr2-sprite-plane-move [131.908665] Starting dynamic subtest: eDP-1 [131.912993] Dynamic subtest eDP-1: SKIP (0.000s) [131.917214] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s) [131.974544] [013/131] (891s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [132.101972] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [132.106099] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [132.194669] [014/131] (890s left) gem_exec_whisper (basic-contexts-forked) [132.269829] Starting subtest: basic-contexts-forked [155.351802] Subtest basic-contexts-forked: SUCCESS (23.078s) [155.533173] [015/131] (867s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [155.639618] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [155.641876] Starting dynamic subtest: pipe-A-default-mode [155.925470] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [155.930395] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.284s) [156.789464] [016/131] (866s left) gem_mmap_gtt (basic-wc) [156.861401] Subtest basic-wc: SKIP (0.000s) [156.922918] [017/131] (866s left) perf (missing-sample-flags) [157.000424] Starting subtest: missing-sample-flags [157.002991] Subtest missing-sample-flags: SUCCESS (0.000s) [157.037643] [018/131] (866s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [157.099481] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [157.202135] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s) [157.273940] [019/131] (866s left) kms_big_fb (y-tiled-32bpp-rotate-0) [157.388438] Starting subtest: y-tiled-32bpp-rotate-0 [157.392626] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [157.497245] [020/131] (865s left) kms_big_fb (linear-addfb) [157.604814] Starting subtest: linear-addfb [157.606875] Subtest linear-addfb: SUCCESS (0.000s) [157.708216] [021/131] (865s left) gem_ctx_isolation (preservation-s3) [157.777358] Starting subtest: preservation-S3 [157.779678] Starting dynamic subtest: rcs0 [174.304904] Dynamic subtest rcs0: SUCCESS (1.512s) [174.315108] Starting dynamic subtest: bcs0 [190.240886] Dynamic subtest bcs0: SUCCESS (1.385s) [190.252174] Starting dynamic subtest: vcs0 [206.239709] Dynamic subtest vcs0: SUCCESS (2.205s) [206.251217] Starting dynamic subtest: vcs1 [224.343859] Dynamic subtest vcs1: SUCCESS (5.018s) [224.354782] Starting dynamic subtest: vecs0 [242.314930] Dynamic subtest vecs0: SUCCESS (4.849s) [242.325458] Starting dynamic subtest: ccs0 [260.248706] Dynamic subtest ccs0: SUCCESS (3.081s) [260.251733] Subtest preservation-S3: SUCCESS (18.051s) [260.508449] [022/131] (847s left) kms_psr (pr-no-drrs) [260.617396] Starting subtest: pr-no-drrs [260.623616] Subtest pr-no-drrs: SKIP (0.000s) [260.687095] [023/131] (847s left) gem_exec_reloc (basic-wc-cpu-active) [260.752581] Subtest basic-wc-cpu-active: SKIP (0.000s) [260.820730] [024/131] (847s left) kms_addfb_basic (invalid-set-prop) [260.880054] Starting subtest: invalid-set-prop [260.882741] Subtest invalid-set-prop: SUCCESS (0.000s) [261.028849] [025/131] (846s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [261.151376] Starting subtest: short-flip-after-cursor-toggle [262.103723] Subtest short-flip-after-cursor-toggle: SUCCESS (0.921s) [262.974350] [026/131] (845s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [263.364561] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [264.206713] [027/131] (843s left) gem_wait (invalid-buf) [264.272550] Starting subtest: invalid-buf [264.275444] Subtest invalid-buf: SUCCESS (0.000s) [264.527693] [028/131] (843s left) gem_userptr_blits (invalid-null-pointer) [264.598433] Starting subtest: invalid-null-pointer [264.601144] Subtest invalid-null-pointer: SUCCESS (0.001s) [264.733911] [029/131] (843s left) gem_mmap_wc (bad-size) [264.795136] Subtest bad-size: SKIP (0.000s) [264.851099] [030/131] (843s left) kms_flip (flip-vs-modeset-vs-hang) [264.962330] Starting subtest: flip-vs-modeset-vs-hang [264.964501] Starting dynamic subtest: A-eDP1 [316.359990] Dynamic subtest A-eDP1: SUCCESS (51.242s) [316.370623] Starting dynamic subtest: D-eDP1 [366.336612] Dynamic subtest D-eDP1: SUCCESS (49.968s) [366.339287] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.215s) [366.726128] [031/131] (741s left) kms_async_flips (alternate-sync-async-flip) [366.822441] Starting subtest: alternate-sync-async-flip [367.193146] Starting dynamic subtest: pipe-A-eDP-1 [370.020562] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.829s) [370.391278] Starting dynamic subtest: pipe-B-eDP-1 [373.144903] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s) [373.512252] Starting dynamic subtest: pipe-C-eDP-1 [376.265222] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.762s) [376.627490] Starting dynamic subtest: pipe-D-eDP-1 [379.393841] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s) [379.396181] Subtest alternate-sync-async-flip: SUCCESS (12.574s) [380.551954] [032/131] (727s left) syncobj_timeline (multi-wait-available-submitted-signaled) [380.615227] Starting subtest: multi-wait-available-submitted-signaled [380.617951] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [380.699775] [033/131] (727s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [380.807383] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [380.810145] Starting dynamic subtest: A-eDP1 [389.695175] Dynamic subtest A-eDP1: SUCCESS (8.886s) [389.704349] Starting dynamic subtest: B-eDP1 [398.625945] Dynamic subtest B-eDP1: SUCCESS (8.929s) [398.635701] Starting dynamic subtest: C-eDP1 [407.546545] Dynamic subtest C-eDP1: SUCCESS (8.917s) [407.556187] Starting dynamic subtest: D-eDP1 [416.476762] Dynamic subtest D-eDP1: SUCCESS (8.928s) [416.479584] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.669s) [417.692483] [034/131] (690s left) kms_addfb_basic (addfb25-x-tiled-legacy) [417.790423] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [417.894326] [035/131] (690s left) kms_pm_dc (dc6-psr) [419.007200] Starting subtest: dc6-psr [426.341724] Subtest dc6-psr: FAIL (6.626s) [426.374926] [036/131] (682s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [426.479277] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [426.482336] Starting dynamic subtest: pipe-A-default-mode [429.237014] Dynamic subtest pipe-A-default-mode: SUCCESS (2.753s) [429.239596] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.754s) [430.073772] [037/131] (678s left) gem_userptr_blits (set-cache-level) [430.143306] Starting subtest: set-cache-level [430.148008] Subtest set-cache-level: SKIP (0.000s) [430.288913] [038/131] (678s left) gem_exec_reloc (basic-gtt-wc-active) [430.352173] Subtest basic-gtt-wc-active: SKIP (0.000s) [430.427672] [039/131] (678s left) gem_lmem_swapping (parallel-random-engines) [430.472395] Subtest parallel-random-engines: SKIP (0.000s) [430.514571] [040/131] (678s left) gem_partial_pwrite_pread (reads) [430.581531] Subtest reads: SKIP (0.000s) [430.644322] [041/131] (678s left) gem_softpin (allocator-basic-reserve) [430.709298] Starting subtest: allocator-basic-reserve [430.775449] Subtest allocator-basic-reserve: SUCCESS (0.067s) [430.909830] [042/131] (677s left) kms_big_fb (linear-16bpp-rotate-0) [431.026333] Starting subtest: linear-16bpp-rotate-0 [432.492256] Subtest linear-16bpp-rotate-0: SUCCESS (1.466s) [432.621611] [043/131] (676s left) fbdev (unaligned-read) [432.668126] Starting subtest: unaligned-read [432.684017] Subtest unaligned-read: SUCCESS (0.016s) [432.730862] [044/131] (676s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [432.835251] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [433.846285] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.011s) [434.006761] [045/131] (674s left) gem_exec_schedule (semaphore-user) [434.072128] Starting subtest: semaphore-user [434.125339] Subtest semaphore-user: SUCCESS (0.057s) [435.922432] [046/131] (673s left) kms_rotation_crc (primary-rotation-270) [436.022178] Starting subtest: primary-rotation-270 [436.027434] Subtest primary-rotation-270: SKIP (0.001s) [436.096086] [047/131] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [436.204887] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [440.792011] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.592s) [440.933808] [048/131] (668s left) drm_buddy (drm_buddy) [440.975380] Starting subtest: drm_buddy [441.009230] Starting dynamic subtest: drm_test_buddy_alloc_limit [441.141712] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.134s) [441.151599] Starting dynamic subtest: drm_test_buddy_alloc_optimistic [441.289161] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.146s) [441.299752] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic [441.374826] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.084s) [441.384569] Starting dynamic subtest: drm_test_buddy_alloc_pathological [441.521585] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.145s) [441.531244] Starting dynamic subtest: drm_test_buddy_alloc_contiguous [441.665545] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.141s) [441.675101] Starting dynamic subtest: drm_test_buddy_alloc_clear [441.811858] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.146s) [441.821028] Starting dynamic subtest: drm_test_buddy_alloc_range_bias [441.958014] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.148s) [441.960598] Subtest drm_buddy: SUCCESS (0.983s) [442.151855] [049/131] (666s left) kms_chamelium_audio (hdmi-audio-edid) [442.548173] Subtest hdmi-audio-edid: SKIP (0.000s) [443.348559] [050/131] (665s left) kms_big_fb (4-tiled-8bpp-rotate-180) [443.453599] Starting subtest: 4-tiled-8bpp-rotate-180 [444.589289] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.135s) [444.729000] [051/131] (664s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [444.787376] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [444.876765] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s) [444.916238] [052/131] (664s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [445.023531] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [445.028108] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [445.132424] [053/131] (664s left) gem_flink_race (flink_close) [445.166304] Starting subtest: flink_close [450.262804] Subtest flink_close: SUCCESS (5.092s) [450.340281] [054/131] (658s left) syncobj_timeline (single-wait-available-submitted) [450.413304] Starting subtest: single-wait-available-submitted [450.416296] Subtest single-wait-available-submitted: SUCCESS (0.000s) [450.508686] [055/131] (658s left) gem_mmap_wc (write-read-distinct) [450.574538] Subtest write-read-distinct: SKIP (0.000s) [450.634542] [056/131] (658s left) kms_dp_link_training (uhbr-mst) [450.746550] Starting subtest: uhbr-mst [450.757974] Subtest uhbr-mst: SKIP (0.000s) [450.812940] [057/131] (658s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [450.918529] Starting subtest: psr-rgb101010-draw-mmap-gtt [450.923545] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [451.017697] [058/131] (658s left) kms_invalid_mode (zero-vdisplay) [451.117809] Starting subtest: zero-vdisplay [451.120336] Starting dynamic subtest: pipe-A-eDP-1 [451.413562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s) [451.422566] Starting dynamic subtest: pipe-B-eDP-1 [451.425291] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [451.433536] Starting dynamic subtest: pipe-C-eDP-1 [451.436021] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [451.444063] Starting dynamic subtest: pipe-D-eDP-1 [451.446366] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [451.448482] Subtest zero-vdisplay: SUCCESS (0.303s) [452.200028] [059/131] (657s left) gem_userptr_blits (process-exit) [452.285545] Starting subtest: process-exit [452.293003] Subtest process-exit: SUCCESS (0.009s) [452.432991] [060/131] (657s left) kms_feature_discovery (display-3x) [452.533106] Starting subtest: display-3x [452.537753] Subtest display-3x: SKIP (0.000s) [452.602655] [061/131] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [452.718251] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [452.722727] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [452.837191] [062/131] (656s left) kms_universal_plane (cursor-fb-leak) [452.941986] Starting subtest: cursor-fb-leak [452.944413] Starting dynamic subtest: pipe-A-eDP-1 [453.258628] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.316s) [453.267550] Starting dynamic subtest: pipe-B-eDP-1 [454.606924] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.347s) [454.615309] Starting dynamic subtest: pipe-C-eDP-1 [456.654577] Dynamic subtest pipe-C-eDP-1: FAIL (1.315s) [456.663349] Starting dynamic subtest: pipe-D-eDP-1 [457.244661] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s) [457.247300] Subtest cursor-fb-leak: FAIL (4.300s) [458.416902] [063/131] (651s left) kms_vrr (seamless-rr-switch-virtual) [458.507164] Starting subtest: seamless-rr-switch-virtual [458.514801] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [458.578180] [064/131] (651s left) kms_plane_alpha_blend (alpha-7efc) [458.672339] Starting subtest: alpha-7efc [459.105145] Starting dynamic subtest: pipe-A-eDP-1 [459.679176] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.571s) [459.701117] Starting dynamic subtest: pipe-D-eDP-1 [461.009475] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s) [461.012093] Subtest alpha-7efc: SUCCESS (2.335s) [461.871067] [065/131] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [461.976325] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [461.980899] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [462.066080] [066/131] (647s left) kms_chamelium_hpd (vga-hpd-fast) [462.441126] Subtest vga-hpd-fast: SKIP (0.000s) [463.278973] [067/131] (646s left) gem_exec_reloc (basic-write-wc) [463.352736] Subtest basic-write-wc: SKIP (0.000s) [463.401792] [068/131] (646s left) sysfs_timeslice_duration (duration) [463.468380] Starting subtest: duration [463.471312] Starting dynamic subtest: vecs0 [476.809889] Dynamic subtest vecs0: SUCCESS (13.335s) [476.821518] Starting dynamic subtest: ccs0 [489.993182] Dynamic subtest ccs0: SUCCESS (13.182s) [490.004545] Starting dynamic subtest: vcs0 [504.842342] Dynamic subtest vcs0: SUCCESS (14.848s) [504.853717] Starting dynamic subtest: bcs0 [517.998039] Dynamic subtest bcs0: SUCCESS (13.155s) [518.016581] Starting dynamic subtest: rcs0 [531.162301] Dynamic subtest rcs0: SUCCESS (13.161s) [531.174044] Starting dynamic subtest: vcs1 [545.803257] Dynamic subtest vcs1: SUCCESS (14.637s) [545.806397] Subtest duration: SUCCESS (82.334s) [545.877253] [069/131] (563s left) syncobj_wait (invalid-signal-illegal-handle) [545.937030] Starting subtest: invalid-signal-illegal-handle [545.939553] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [546.053671] [070/131] (563s left) kms_frontbuffer_tracking (pipe-fbc-rte) [546.154108] Starting subtest: pipe-fbc-rte [546.161426] Starting dynamic subtest: pipe-B-eDP-1 [550.551563] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.402s) [550.560384] Subtest pipe-fbc-rte: SUCCESS (4.404s) [551.736872] [071/131] (558s left) gem_fenced_exec_thrash (too-many-fences) [551.798882] Subtest too-many-fences: SKIP (0.000s) [551.872214] [072/131] (558s left) i915_pm_rpm (system-suspend-devices) [554.030161] Starting subtest: system-suspend-devices [561.599189] Subtest system-suspend-devices: SUCCESS (7.568s) [561.964458] [073/131] (548s left) api_intel_bb (reset-flags) [562.027343] Starting subtest: reset-flags [562.032313] Subtest reset-flags: SUCCESS (0.009s) [562.165946] [074/131] (547s left) kms_cursor_crc (cursor-sliding-512x512) [562.413664] Starting subtest: cursor-sliding-512x512 [562.418589] Subtest cursor-sliding-512x512: SKIP (0.001s) [562.594409] [075/131] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [562.719269] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [562.724847] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [562.799839] [076/131] (547s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [562.855803] Starting subtest: invalid-multi-wait-unsubmitted-submitted [562.858411] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [562.936841] [077/131] (547s left) gem_exec_reloc (basic-scanout) [562.997882] Subtest basic-scanout: SKIP (0.000s) [563.071354] [078/131] (547s left) gem_pxp (reject-modify-context-protection-off-1) [563.189859] Starting subtest: reject-modify-context-protection-off-1 [563.192201] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s) [563.289626] [079/131] (546s left) sysfs_defaults (readonly) [563.342197] Starting subtest: readonly [563.344531] Starting dynamic subtest: vecs0 [563.347237] Dynamic subtest vecs0: SUCCESS (0.000s) [563.358201] Starting dynamic subtest: ccs0 [563.360346] Dynamic subtest ccs0: SUCCESS (0.000s) [563.368390] Starting dynamic subtest: vcs0 [563.370829] Dynamic subtest vcs0: SUCCESS (0.000s) [563.378930] Starting dynamic subtest: bcs0 [563.381483] Dynamic subtest bcs0: SUCCESS (0.000s) [563.390534] Starting dynamic subtest: rcs0 [563.393083] Dynamic subtest rcs0: SUCCESS (0.000s) [563.400913] Starting dynamic subtest: vcs1 [563.402709] Dynamic subtest vcs1: SUCCESS (0.000s) [563.404404] Subtest readonly: SUCCESS (0.004s) [563.452569] [080/131] (546s left) gem_exec_balancer (fairslice) [563.525039] Starting subtest: fairslice [566.302811] Subtest fairslice: SUCCESS (2.775s) [566.913323] [081/131] (543s left) i915_query (query-topology-unsupported) [566.974346] Starting subtest: query-topology-unsupported [566.979407] Subtest query-topology-unsupported: SKIP (0.000s) [567.084741] [082/131] (543s left) gen9_exec_parse (secure-batches) [567.149983] Subtest secure-batches: SKIP (0.000s) [567.244915] [083/131] (543s left) kms_psr (fbc-pr-primary-blt) [567.357378] Starting subtest: fbc-pr-primary-blt [567.362536] Subtest fbc-pr-primary-blt: SKIP (0.000s) [567.421652] [084/131] (542s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [567.506267] Starting subtest: crc-primary-suspend-yf-tiled-ccs [567.508914] Starting dynamic subtest: pipe-A-eDP-1 [567.519538] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [567.528637] Starting dynamic subtest: pipe-B-eDP-1 [567.539302] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [567.547592] Starting dynamic subtest: pipe-C-eDP-1 [567.558329] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [567.566536] Starting dynamic subtest: pipe-D-eDP-1 [567.577397] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [567.582812] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s) [569.686942] [085/131] (540s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [569.794456] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [569.799564] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [569.898047] [086/131] (540s left) kms_pm_rpm (basic-rte) [569.933053] Starting subtest: basic-rte [573.484320] Subtest basic-rte: SUCCESS (3.550s) [575.266440] [087/131] (535s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [575.380698] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [575.385206] Starting dynamic subtest: pipe-A-eDP-1 [575.410212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [575.419096] Starting dynamic subtest: pipe-B-eDP-1 [575.445592] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [575.454214] Starting dynamic subtest: pipe-C-eDP-1 [575.480983] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [575.490139] Starting dynamic subtest: pipe-D-eDP-1 [575.516033] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [575.520924] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s) [577.600581] [088/131] (532s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [577.715098] Starting subtest: primary-yf-tiled-reflect-x-90 [577.720140] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [577.784638] [089/131] (532s left) api_intel_bb (full-batch) [577.853565] Starting subtest: full-batch [577.858529] Subtest full-batch: SUCCESS (0.006s) [577.979902] [090/131] (532s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [578.075446] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [578.078238] Starting dynamic subtest: pipe-A [578.146357] Dynamic subtest pipe-A: SUCCESS (0.073s) [578.156538] Starting dynamic subtest: pipe-B [579.331401] Dynamic subtest pipe-B: SUCCESS (1.185s) [579.340277] Starting dynamic subtest: pipe-C [580.444097] Dynamic subtest pipe-C: SUCCESS (1.111s) [580.453298] Starting dynamic subtest: pipe-D [581.575861] Dynamic subtest pipe-D: SUCCESS (1.131s) [581.578716] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.504s) [582.717685] [091/131] (527s left) kms_prop_blob (invalid-get-prop-any) [582.783394] Starting subtest: invalid-get-prop-any [582.785984] Subtest invalid-get-prop-any: SUCCESS (0.000s) [582.893321] [092/131] (527s left) kms_busy (extended-modeset-hang-newfb-with-reset) [583.009449] Starting subtest: extended-modeset-hang-newfb-with-reset [583.012535] Starting dynamic subtest: pipe-A [596.736167] Dynamic subtest pipe-A: SUCCESS (13.723s) [596.746526] Starting dynamic subtest: pipe-D [612.512088] Dynamic subtest pipe-D: SUCCESS (15.768s) [612.514871] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.495s) [613.299869] [093/131] (497s left) i915_pm_rpm (debugfs-forcewake-user) [615.051678] Starting subtest: debugfs-forcewake-user [626.453160] Subtest debugfs-forcewake-user: SUCCESS (11.399s) [626.814862] [094/131] (483s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [626.915375] Starting subtest: fbc-dirtyfb-ioctl [626.918192] Starting dynamic subtest: A-eDP-1 [628.537187] Dynamic subtest A-eDP-1: SUCCESS (1.619s) [628.539854] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.620s) [629.331176] [095/131] (481s left) kms_psr (psr-no-drrs) [629.437553] Starting subtest: psr-no-drrs [629.439895] Starting dynamic subtest: eDP-1 [631.107087] Dynamic subtest eDP-1: SUCCESS (1.670s) [631.109825] Subtest psr-no-drrs: SUCCESS (1.671s) [631.892791] [096/131] (478s left) kms_cursor_crc (cursor-onscreen-64x64) [632.065579] Starting subtest: cursor-onscreen-64x64 [632.068388] Starting dynamic subtest: pipe-A-eDP-1 [634.492447] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.423s) [634.517566] Starting dynamic subtest: pipe-D-eDP-1 [637.555549] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.045s) [637.558336] Subtest cursor-onscreen-64x64: SUCCESS (5.490s) [638.353847] [097/131] (472s left) gem_ctx_engines (invalid-engines) [638.419533] Starting subtest: invalid-engines [638.427922] Subtest invalid-engines: SUCCESS (0.009s) [638.672982] [098/131] (472s left) kms_chamelium_color (degamma) [638.770338] Subtest degamma: SKIP (0.000s) [638.810667] [099/131] (472s left) kms_psr2_su (page_flip-xrgb8888) [638.870367] Subtest page_flip-XRGB8888: SKIP (0.000s) [638.928683] [100/131] (472s left) gem_exec_nop (basic-sequential) [638.998385] Starting subtest: basic-sequential [653.412179] Subtest basic-sequential: SUCCESS (14.423s) [653.651708] [101/131] (457s left) kms_psr (psr2-no-drrs) [653.754555] Starting subtest: psr2-no-drrs [653.757413] Starting dynamic subtest: eDP-1 [655.313088] Dynamic subtest eDP-1: SUCCESS (1.558s) [655.315222] Subtest psr2-no-drrs: SUCCESS (1.559s) [656.101697] [102/131] (454s left) gem_create (create-clear) [656.170484] Starting subtest: create-clear [656.173372] Starting dynamic subtest: smem0 [690.611478] Dynamic subtest smem0: SUCCESS (34.429s) [690.614441] Subtest create-clear: SUCCESS (34.431s) [690.802127] [103/131] (420s left) gem_userptr_blits (sync-overlap) [690.893489] Starting subtest: sync-overlap [690.896317] Subtest sync-overlap: SUCCESS (0.000s) [691.035378] [104/131] (420s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [691.145894] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [691.151356] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [691.241745] [105/131] (419s left) kms_properties (get_properties-sanity-non-atomic) [691.353219] Starting subtest: get_properties-sanity-non-atomic [691.355404] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s) [691.422795] [106/131] (419s left) gem_exec_reloc (basic-cpu-gtt) [691.496863] Subtest basic-cpu-gtt: SKIP (0.000s) [691.644169] [107/131] (419s left) kms_flip (2x-busy-flip) [691.819287] Starting subtest: 2x-busy-flip [691.830671] Subtest 2x-busy-flip: SKIP (0.011s) [691.954364] [108/131] (419s left) syncobj_timeline (invalid-signal-bad-pad) [692.017562] Starting subtest: invalid-signal-bad-pad [692.020403] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [692.139773] [109/131] (419s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [692.252053] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [692.257189] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [692.354938] [110/131] (419s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite) [692.458399] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite [696.398531] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (3.945s) [696.532417] [111/131] (414s left) gem_ctx_sseu (engines) [696.602415] Subtest engines: SKIP (0.000s) [696.668482] [112/131] (414s left) perf_pmu (enable-race) [696.715464] Starting subtest: enable-race [696.718255] Starting dynamic subtest: rcs0 [709.477801] Dynamic subtest rcs0: SUCCESS (12.762s) [709.489359] Starting dynamic subtest: bcs0 [722.235918] Dynamic subtest bcs0: SUCCESS (12.755s) [722.247570] Starting dynamic subtest: vcs0 [737.900276] Dynamic subtest vcs0: SUCCESS (15.658s) [737.911608] Starting dynamic subtest: vcs1 [753.900137] Dynamic subtest vcs1: SUCCESS (15.995s) [753.910567] Starting dynamic subtest: vecs0 [769.901381] Dynamic subtest vecs0: SUCCESS (15.996s) [769.912014] Starting dynamic subtest: ccs0 [782.661841] Dynamic subtest ccs0: SUCCESS (12.757s) [782.664902] Subtest enable-race: SUCCESS (85.933s) [782.766556] [113/131] (328s left) kms_content_protection (legacy) [782.941260] Starting subtest: legacy [786.739007] Subtest legacy: SKIP (3.794s) [787.935806] [114/131] (323s left) gem_mmap_gtt (fault-concurrent) [787.999450] Subtest fault-concurrent: SKIP (0.000s) [788.048699] [115/131] (323s left) kms_addfb_basic (no-handle) [788.103605] Starting subtest: no-handle [788.106571] Subtest no-handle: SUCCESS (0.000s) [788.246397] [116/131] (323s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [788.343339] Starting subtest: plane-downscale-factor-0-5-with-modifiers [788.345727] Starting dynamic subtest: pipe-A [788.355276] Dynamic subtest pipe-A: SKIP (0.004s) [788.366837] Starting dynamic subtest: pipe-B [788.378216] Dynamic subtest pipe-B: SKIP (0.015s) [788.393017] Starting dynamic subtest: pipe-C [788.403313] Dynamic subtest pipe-C: SKIP (0.015s) [788.413445] Starting dynamic subtest: pipe-D [788.422990] Dynamic subtest pipe-D: SKIP (0.016s) [788.427862] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.053s) [788.509228] [117/131] (323s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [788.609180] Starting subtest: verify-pxp-execution-after-suspend-resume [795.567713] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.959s) [795.707547] [118/131] (315s left) gem_wait (busy) [795.770954] Starting subtest: busy [795.773580] Starting dynamic subtest: all-engines [796.908271] Dynamic subtest all-engines: SUCCESS (1.135s) [796.920559] Starting dynamic subtest: rcs0 [797.448572] Dynamic subtest rcs0: SUCCESS (0.539s) [797.458923] Starting dynamic subtest: bcs0 [797.986813] Dynamic subtest bcs0: SUCCESS (0.537s) [797.997525] Starting dynamic subtest: vcs0 [799.915656] Dynamic subtest vcs0: SUCCESS (1.927s) [799.927355] Starting dynamic subtest: vcs1 [801.899881] Dynamic subtest vcs1: SUCCESS (1.981s) [801.912414] Starting dynamic subtest: vecs0 [803.885491] Dynamic subtest vecs0: SUCCESS (1.983s) [803.896736] Starting dynamic subtest: ccs0 [804.428349] Dynamic subtest ccs0: SUCCESS (0.542s) [804.431335] Subtest busy: SUCCESS (8.657s) [804.630080] [119/131] (307s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [804.726061] Starting subtest: compare-crc-sanitycheck-xr24 [804.728302] Starting dynamic subtest: pipe-A-eDP-1 [805.356855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.630s) [805.367537] Starting dynamic subtest: pipe-B-eDP-1 [806.631322] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.275s) [806.640315] Starting dynamic subtest: pipe-C-eDP-1 [807.817443] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.183s) [807.828533] Starting dynamic subtest: pipe-D-eDP-1 [809.036529] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s) [809.038949] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.311s) [809.897143] [120/131] (301s left) perf_pmu (multi-client) [809.937581] Starting subtest: multi-client [809.940057] Starting dynamic subtest: rcs0 [811.023161] Dynamic subtest rcs0: SUCCESS (1.085s) [811.034667] Starting dynamic subtest: bcs0 [812.072381] Dynamic subtest bcs0: SUCCESS (1.047s) [812.083197] Starting dynamic subtest: vcs0 [813.119602] Dynamic subtest vcs0: SUCCESS (1.045s) [813.130585] Starting dynamic subtest: vcs1 [814.948018] Dynamic subtest vcs1: SUCCESS (1.825s) [814.960281] Starting dynamic subtest: vecs0 [816.932752] Dynamic subtest vecs0: SUCCESS (1.982s) [816.943778] Starting dynamic subtest: ccs0 [818.915371] Dynamic subtest ccs0: SUCCESS (1.981s) [818.918604] Subtest multi-client: SUCCESS (8.977s) [819.051809] [121/131] (292s left) perf_pmu (all-busy-idle-check-all) [819.092534] Starting subtest: all-busy-idle-check-all [820.909062] Subtest all-busy-idle-check-all: SUCCESS (1.816s) [821.007879] [122/131] (290s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt) [821.122243] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt [821.127913] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [821.232455] [123/131] (290s left) gem_exec_fence (submit67) [821.412579] Starting subtest: submit67 [821.418556] Subtest submit67: SKIP (0.000s) [822.978265] [124/131] (288s left) gem_exec_schedule (preempt-hang) [823.152447] Starting subtest: preempt-hang [823.155337] Starting dynamic subtest: rcs0 [823.375789] Dynamic subtest rcs0: SUCCESS (0.222s) [823.385155] Starting dynamic subtest: bcs0 [823.593554] Dynamic subtest bcs0: SUCCESS (0.215s) [823.606218] Starting dynamic subtest: vcs0 [823.816933] Dynamic subtest vcs0: SUCCESS (0.222s) [823.827611] Starting dynamic subtest: vcs1 [824.036647] Dynamic subtest vcs1: SUCCESS (0.219s) [824.057588] Starting dynamic subtest: vecs0 [824.273723] Dynamic subtest vecs0: SUCCESS (0.234s) [824.283563] Starting dynamic subtest: ccs0 [824.520847] Dynamic subtest ccs0: SUCCESS (0.250s) [824.523536] Subtest preempt-hang: SUCCESS (1.368s) [824.967934] [125/131] (287s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [825.079576] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [830.195708] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.119s) [830.326886] [126/131] (281s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [830.445818] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [830.450583] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [830.552710] [127/131] (281s left) kms_setmode (invalid-clone-single-crtc) [830.617569] Starting subtest: invalid-clone-single-crtc [830.626034] Subtest invalid-clone-single-crtc: SKIP (0.000s) [830.725125] [128/131] (281s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [830.822363] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [830.827547] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [831.978890] [129/131] (280s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [837.020223] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [837.025437] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s) [837.868211] [130/131] (274s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [837.984980] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [842.871569] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (4.888s) [843.025378] [131/131] (269s left) gem_media_fill (media-fill) [843.086402] Subtest media-fill: SKIP (0.000s) [843.196412] Closing watchdogs Done.