[57.522920] Initializing watchdogs [57.522981] /dev/watchdog0 [57.535193] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.539527] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.541580] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.544773] [001/130] (960s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [57.711095] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [57.713507] Starting dynamic subtest: pipe-A-default-mode [60.345691] Dynamic subtest pipe-A-default-mode: SUCCESS (2.649s) [60.348259] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.650s) [61.112378] [002/130] (956s left) kms_fbcon_fbt (fbc) [61.175459] Starting subtest: fbc [66.391903] Subtest fbc: SUCCESS (5.232s) [66.458416] [003/130] (951s left) syncobj_timeline (multi-wait-available-signaled) [66.518611] Starting subtest: multi-wait-available-signaled [66.521143] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [66.615734] [004/130] (951s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [66.746609] Starting subtest: short-busy-flip-before-cursor-toggle [66.750877] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [66.838098] [005/130] (951s left) gem_ctx_persistence (saturated-hostile-nopreempt) [66.906488] Starting subtest: saturated-hostile-nopreempt [66.909141] Starting dynamic subtest: rcs0 [67.009857] Dynamic subtest rcs0: SKIP (0.100s) [67.016786] Starting dynamic subtest: bcs0 [67.029763] Dynamic subtest bcs0: SKIP (0.021s) [67.035615] Starting dynamic subtest: vcs0 [67.048880] Dynamic subtest vcs0: SKIP (0.019s) [67.054741] Starting dynamic subtest: vcs1 [67.067366] Dynamic subtest vcs1: SKIP (0.019s) [67.073116] Starting dynamic subtest: vecs0 [67.092458] Dynamic subtest vecs0: SKIP (0.025s) [67.098152] Starting dynamic subtest: ccs0 [67.117628] Dynamic subtest ccs0: SKIP (0.025s) [67.121654] Subtest saturated-hostile-nopreempt: SKIP (0.210s) [67.181736] [006/130] (950s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [72.193028] Starting subtest: pr-cursor-plane-move-continuous-sf [72.197765] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s) [73.044078] [007/130] (945s left) tools_test (sysfs_l3_parity) [73.091508] Starting subtest: sysfs_l3_parity [73.146448] Subtest sysfs_l3_parity: SKIP (0.070s) [73.193071] [008/130] (945s left) i915_pm_rps (reset) [73.258789] Starting subtest: reset [73.337636] Subtest reset: FAIL (0.014s) [73.402027] [009/130] (944s left) kms_lease (empty-lease) [73.487864] Starting subtest: empty-lease [73.490624] Starting dynamic subtest: pipe-A-eDP-1 [73.492935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [73.499502] Starting dynamic subtest: pipe-B-eDP-1 [73.501396] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [73.507267] Starting dynamic subtest: pipe-C-eDP-1 [73.509100] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [73.514937] Starting dynamic subtest: pipe-D-eDP-1 [73.516781] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [73.518658] Subtest empty-lease: SUCCESS (0.006s) [73.592655] [010/130] (944s left) kms_tiled_display (basic-test-pattern) [73.719030] Subtest basic-test-pattern: SKIP (0.000s) [73.754323] [011/130] (944s left) gem_userptr_blits (usage-restrictions) [73.821133] Starting subtest: usage-restrictions [73.823127] Subtest usage-restrictions: SUCCESS (0.000s) [73.966362] [012/130] (944s left) kms_invalid_mode (zero-hdisplay) [74.052557] Starting subtest: zero-hdisplay [74.054566] Starting dynamic subtest: pipe-A-eDP-1 [74.338560] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [74.346225] Starting dynamic subtest: pipe-B-eDP-1 [74.348322] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [74.354099] Starting dynamic subtest: pipe-C-eDP-1 [74.356235] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [74.362039] Starting dynamic subtest: pipe-D-eDP-1 [74.363882] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [74.365716] Subtest zero-hdisplay: SUCCESS (0.287s) [75.160366] [013/130] (943s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [75.285232] Starting subtest: short-flip-after-cursor-atomic-transitions [76.265976] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.981s) [77.085190] [014/130] (941s left) kms_atomic_interruptible (legacy-setmode) [77.181689] Starting subtest: legacy-setmode [77.183960] Starting dynamic subtest: pipe-A-eDP-1 [84.062652] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.884s) [84.065094] Subtest legacy-setmode: SUCCESS (6.884s) [84.916189] [015/130] (933s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [85.295478] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [86.116588] [016/130] (932s left) i915_pm_rc6_residency (rc6-fence) [86.167971] Starting subtest: rc6-fence [86.184605] Starting dynamic subtest: gt0 [98.506759] Dynamic subtest gt0: SUCCESS (12.321s) [98.516816] Starting dynamic subtest: gt1 [112.875374] Dynamic subtest gt1: SUCCESS (14.366s) [112.878251] Subtest rc6-fence: SUCCESS (26.708s) [112.941256] [017/130] (905s left) sw_sync (sync_busy_fork_unixsocket) [112.981915] Starting subtest: sync_busy_fork_unixsocket [112.987686] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s) [113.030109] [018/130] (905s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [113.135929] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [113.138354] Starting dynamic subtest: pipe-A-eDP-1 [113.161220] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [113.170169] Starting dynamic subtest: pipe-B-eDP-1 [113.192077] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [113.198541] Starting dynamic subtest: pipe-C-eDP-1 [113.220400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [113.226887] Starting dynamic subtest: pipe-D-eDP-1 [113.249199] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [113.253310] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.002s) [115.278214] [019/130] (903s left) kms_addfb_basic (bad-pitch-256) [115.339180] Starting subtest: bad-pitch-256 [115.341646] Subtest bad-pitch-256: SUCCESS (0.000s) [115.466077] [020/130] (903s left) kms_dirtyfb (psr-dirtyfb-ioctl) [115.555116] Starting subtest: psr-dirtyfb-ioctl [115.557538] Starting dynamic subtest: A-eDP-1 [117.388039] Dynamic subtest A-eDP-1: SUCCESS (1.829s) [117.390111] Subtest psr-dirtyfb-ioctl: SUCCESS (1.830s) [118.201198] [021/130] (900s left) kms_psr (fbc-psr2-cursor-plane-onoff) [118.301272] Starting subtest: fbc-psr2-cursor-plane-onoff [118.303698] Starting dynamic subtest: eDP-1 [118.307925] Dynamic subtest eDP-1: SKIP (0.000s) [118.312184] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [118.365945] [022/130] (900s left) gem_ctx_sseu (invalid-sseu) [118.430152] Subtest invalid-sseu: SKIP (0.000s) [118.510703] [023/130] (900s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [118.612853] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [119.646236] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.033s) [119.825993] [024/130] (898s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [119.930813] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [119.934796] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [120.037593] [025/130] (898s left) gem_partial_pwrite_pread (write) [120.086646] Subtest write: SKIP (0.000s) [120.160923] [026/130] (898s left) kms_vrr (max-min) [120.250974] Starting subtest: max-min [120.257896] Subtest max-min: SKIP (0.000s) [120.314877] [027/130] (898s left) testdisplay [120.678818] [028/130] (898s left) gem_mmap_gtt (basic-short) [120.737088] Subtest basic-short: SKIP (0.000s) [120.787700] [029/130] (898s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [120.888315] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [120.891926] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [120.981764] [030/130] (897s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [121.099183] Starting subtest: 2x-long-cursor-vs-flip-legacy [121.102786] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [121.191857] [031/130] (897s left) kms_plane_scaling (planes-downscale-factor-0-75) [121.276482] Starting subtest: planes-downscale-factor-0-75 [121.278417] Starting dynamic subtest: pipe-A [121.295478] Dynamic subtest pipe-A: SKIP (0.014s) [121.303065] Starting dynamic subtest: pipe-B [121.320023] Dynamic subtest pipe-B: SKIP (0.025s) [121.326830] Starting dynamic subtest: pipe-C [121.346062] Dynamic subtest pipe-C: SKIP (0.025s) [121.352741] Starting dynamic subtest: pipe-D [121.369737] Dynamic subtest pipe-D: SKIP (0.025s) [121.373200] Subtest planes-downscale-factor-0-75: SKIP (0.089s) [121.471858] [032/130] (897s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [121.567089] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [126.659921] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (5.094s) [126.774232] [033/130] (892s left) syncobj_timeline (wait-any-complex) [126.834205] Starting subtest: wait-any-complex [126.894636] Subtest wait-any-complex: SUCCESS (0.062s) [126.962535] [034/130] (892s left) gem_lmem_swapping (verify-random-ccs) [127.008208] Subtest verify-random-ccs: SKIP (0.000s) [127.044890] [035/130] (891s left) kms_pm_rpm (modeset-lpsp) [129.080279] Starting subtest: modeset-lpsp [130.528539] Subtest modeset-lpsp: SUCCESS (1.448s) [130.607217] [036/130] (888s left) gem_exec_schedule (fairslice-all) [130.680784] Starting subtest: fairslice-all [132.739603] Subtest fairslice-all: SUCCESS (2.063s) [133.970483] [037/130] (885s left) gem_create (create-massive) [134.024474] Starting subtest: create-massive [134.026493] Subtest create-massive: SUCCESS (0.000s) [134.203166] [038/130] (884s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [134.300067] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [134.304917] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [134.386234] [039/130] (884s left) gem_exercise_blt (fast-copy-emit) [134.446150] Starting subtest: fast-copy-emit [134.448593] Starting dynamic subtest: linear-smem-smem-emit [134.468876] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s) [134.475826] Starting dynamic subtest: xmajor-smem-smem-emit [134.490104] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.021s) [134.497355] Starting dynamic subtest: tile4-smem-smem-emit [134.507355] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s) [134.514388] Starting dynamic subtest: tile64-smem-smem-emit [134.524476] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s) [134.526709] Subtest fast-copy-emit: SUCCESS (0.079s) [134.662094] [040/130] (884s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [134.769660] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [134.774052] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [134.847099] [041/130] (884s left) gem_userptr_blits (map-fixed-invalidate-busy) [134.906783] Starting subtest: map-fixed-invalidate-busy [134.911310] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [135.025474] [042/130] (884s left) kms_cursor_crc (cursor-random-128x128) [135.199986] Starting subtest: cursor-random-128x128 [135.203935] Starting dynamic subtest: pipe-A-eDP-1 [138.799872] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.595s) [138.827269] Starting dynamic subtest: pipe-D-eDP-1 [143.038811] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.220s) [143.041062] Subtest cursor-random-128x128: SUCCESS (7.838s) [143.830166] [043/130] (875s left) gem_bad_reloc (negative-reloc) [143.894839] Subtest negative-reloc: SKIP (0.000s) [143.943416] [044/130] (875s left) kms_big_fb (4-tiled-16bpp-rotate-90) [144.052250] Starting subtest: 4-tiled-16bpp-rotate-90 [144.072086] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s) [144.184683] [045/130] (875s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [144.289085] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [144.300498] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s) [144.366412] [046/130] (875s left) device_reset (unbind-cold-reset-rebind) [144.413437] Starting subtest: unbind-cold-reset-rebind [144.418304] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [144.465719] [047/130] (874s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [144.523315] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [144.568901] [048/130] (874s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [144.661957] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [144.664171] Starting dynamic subtest: pipe-A-eDP-1 [144.685966] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [144.693031] Starting dynamic subtest: pipe-B-eDP-1 [144.714944] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [144.721935] Starting dynamic subtest: pipe-C-eDP-1 [144.743602] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [144.750294] Starting dynamic subtest: pipe-D-eDP-1 [144.771288] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [144.774824] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s) [146.789012] [049/130] (872s left) debugfs_test (read_all_entries) [146.850709] Starting subtest: read_all_entries [147.122111] Subtest read_all_entries: SUCCESS (0.270s) [147.229723] [050/130] (872s left) gem_softpin (evict-active) [147.295714] Starting subtest: evict-active [147.301948] Subtest evict-active: SUCCESS (0.006s) [147.430922] [051/130] (872s left) gem_exec_flush (basic-wb-set-default) [147.491200] Starting subtest: basic-wb-set-default [152.960205] Subtest basic-wb-set-default: SUCCESS (5.469s) [153.141999] [052/130] (866s left) kms_psr (fbc-pr-dpms) [153.246360] Starting subtest: fbc-pr-dpms [153.250886] Subtest fbc-pr-dpms: SKIP (0.000s) [153.310904] [053/130] (866s left) gem_softpin (evict-snoop) [153.370418] Starting subtest: evict-snoop [153.375315] Subtest evict-snoop: SKIP (0.000s) [153.522887] [054/130] (866s left) gem_ctx_bad_destroy (double-destroy) [153.584032] Starting subtest: double-destroy [153.586269] Subtest double-destroy: SUCCESS (0.000s) [153.647273] [055/130] (866s left) gem_exec_balancer (waits) [153.710597] Starting subtest: waits [160.017790] Subtest waits: SUCCESS (6.305s) [160.306214] [056/130] (859s left) kms_addfb_basic (legacy-format) [160.371331] Starting subtest: legacy-format [160.391423] Subtest legacy-format: SUCCESS (0.018s) [160.534976] [057/130] (859s left) syncobj_eventfd (timeline-wait) [160.600432] Starting subtest: timeline-wait [160.608987] Subtest timeline-wait: SUCCESS (0.010s) [160.709619] [058/130] (859s left) kms_psr (psr-sprite-render) [160.810364] Starting subtest: psr-sprite-render [160.812668] Starting dynamic subtest: eDP-1 [162.510466] Dynamic subtest eDP-1: SUCCESS (1.697s) [162.512395] Subtest psr-sprite-render: SUCCESS (1.698s) [163.339425] [059/130] (856s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [168.290637] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [168.295563] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s) [169.147537] [060/130] (850s left) gem_ctx_isolation (preservation-reset) [169.322859] Starting subtest: preservation-reset [169.325862] Starting dynamic subtest: rcs0 [169.720497] Dynamic subtest rcs0: SUCCESS (0.399s) [169.730750] Starting dynamic subtest: bcs0 [170.177989] Dynamic subtest bcs0: SUCCESS (0.456s) [170.188174] Starting dynamic subtest: vcs0 [170.622889] Dynamic subtest vcs0: SUCCESS (0.445s) [170.632660] Starting dynamic subtest: vcs1 [172.376507] Dynamic subtest vcs1: SUCCESS (1.752s) [172.386886] Starting dynamic subtest: vecs0 [174.365407] Dynamic subtest vecs0: SUCCESS (1.989s) [174.375311] Starting dynamic subtest: ccs0 [176.361271] Dynamic subtest ccs0: SUCCESS (1.996s) [176.363796] Subtest preservation-reset: SUCCESS (7.042s) [176.527319] [061/130] (843s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [176.626060] Starting subtest: plane-upscale-20x20-with-rotation [176.628445] Starting dynamic subtest: pipe-A [176.852462] Dynamic subtest pipe-A: SUCCESS (0.226s) [176.861353] Starting dynamic subtest: pipe-B [178.135070] Dynamic subtest pipe-B: SUCCESS (1.282s) [178.143415] Starting dynamic subtest: pipe-C [179.455213] Dynamic subtest pipe-C: SUCCESS (1.320s) [179.462999] Starting dynamic subtest: pipe-D [180.781279] Dynamic subtest pipe-D: SUCCESS (1.325s) [180.783790] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.156s) [181.947417] [062/130] (837s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [182.050207] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [182.052528] Starting dynamic subtest: pipe-A-default-mode [182.336450] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [182.341267] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.283s) [183.166140] [063/130] (836s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [183.281658] Starting subtest: fbc-rgb101010-draw-mmap-gtt [183.285874] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [183.368885] [064/130] (836s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [183.429563] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [183.433744] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [183.605088] [065/130] (836s left) kms_psr (pr-primary-page-flip) [183.708475] Starting subtest: pr-primary-page-flip [183.713319] Subtest pr-primary-page-flip: SKIP (0.000s) [183.779049] [066/130] (836s left) gem_exec_reloc (basic-write-read-active) [183.843042] Subtest basic-write-read-active: SKIP (0.000s) [183.900939] [067/130] (836s left) kms_setmode (invalid-clone-single-crtc-stealing) [183.960740] Starting subtest: invalid-clone-single-crtc-stealing [183.967512] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [184.058682] [068/130] (836s left) gen7_exec_parse (chained-batch) [184.119519] Subtest chained-batch: SKIP (0.000s) [184.172818] [069/130] (835s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [184.263148] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [184.350856] [070/130] (835s left) gem_mmap_offset (bad-object) [184.415687] Starting subtest: bad-object [184.418176] Subtest bad-object: SUCCESS (0.001s) [184.519514] [071/130] (835s left) perf_pmu (init-sema) [184.559775] Starting subtest: init-sema [184.561637] Starting dynamic subtest: rcs0 [184.563535] Dynamic subtest rcs0: SUCCESS (0.002s) [184.570436] Starting dynamic subtest: bcs0 [184.572113] Dynamic subtest bcs0: SUCCESS (0.001s) [184.578486] Starting dynamic subtest: vcs0 [184.580079] Dynamic subtest vcs0: SUCCESS (0.001s) [184.586326] Starting dynamic subtest: vcs1 [184.587899] Dynamic subtest vcs1: SUCCESS (0.001s) [184.594811] Starting dynamic subtest: vecs0 [184.596649] Dynamic subtest vecs0: SUCCESS (0.000s) [184.603118] Starting dynamic subtest: ccs0 [184.604935] Dynamic subtest ccs0: SUCCESS (0.001s) [184.606862] Subtest init-sema: SUCCESS (0.007s) [184.673024] [072/130] (835s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [189.721027] Starting subtest: pr-overlay-primary-update-sf-dmg-area [189.725780] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.005s) [190.564478] [073/130] (829s left) i915_hangman (detector) [190.634506] Starting subtest: detector [190.636775] Starting dynamic subtest: rcs0 [201.865557] Dynamic subtest rcs0: SUCCESS (11.230s) [201.876069] Starting dynamic subtest: bcs0 [213.897739] Dynamic subtest bcs0: SUCCESS (12.030s) [213.908086] Starting dynamic subtest: vcs0 [224.843024] Dynamic subtest vcs0: SUCCESS (10.943s) [224.851645] Starting dynamic subtest: vcs1 [235.849708] Dynamic subtest vcs1: SUCCESS (11.004s) [235.860264] Starting dynamic subtest: vecs0 [246.858687] Dynamic subtest vecs0: SUCCESS (11.006s) [246.869764] Starting dynamic subtest: ccs0 [257.930482] Dynamic subtest ccs0: SUCCESS (11.069s) [257.933341] Subtest detector: SUCCESS (67.296s) [258.043453] [074/130] (762s left) gem_userptr_blits (process-exit-busy) [258.105278] Starting subtest: process-exit-busy [258.121946] Subtest process-exit-busy: SUCCESS (0.017s) [258.241336] [075/130] (762s left) drm_fdinfo (virtual-busy-idle-all) [258.280448] Starting subtest: virtual-busy-idle-all [258.284995] Subtest virtual-busy-idle-all: SKIP (0.000s) [258.339989] [076/130] (761s left) kms_flip (2x-plain-flip) [258.439928] Starting subtest: 2x-plain-flip [258.451525] Subtest 2x-plain-flip: SKIP (0.011s) [258.527193] [077/130] (761s left) perf_pmu (busy-accuracy-98) [258.568240] Starting subtest: busy-accuracy-98 [258.570507] Starting dynamic subtest: rcs0 [261.611677] Dynamic subtest rcs0: SUCCESS (3.041s) [261.621077] Starting dynamic subtest: bcs0 [264.675368] Dynamic subtest bcs0: SUCCESS (3.063s) [264.685403] Starting dynamic subtest: vcs0 [267.724967] Dynamic subtest vcs0: SUCCESS (3.046s) [267.741956] Starting dynamic subtest: vcs1 [270.772260] Dynamic subtest vcs1: SUCCESS (3.045s) [270.781923] Starting dynamic subtest: vecs0 [273.818919] Dynamic subtest vecs0: SUCCESS (3.044s) [273.827671] Starting dynamic subtest: ccs0 [276.881486] Dynamic subtest ccs0: SUCCESS (3.061s) [276.883932] Subtest busy-accuracy-98: SUCCESS (18.312s) [276.991292] [078/130] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite) [277.099369] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite [284.263953] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.167s) [284.406286] [079/130] (736s left) kms_color (deep-color) [284.503851] Starting subtest: deep-color [285.603216] Starting dynamic subtest: pipe-A-eDP-1-gamma [286.333068] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.727s) [286.346389] Starting dynamic subtest: pipe-A-eDP-1-degamma [287.775701] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.443s) [287.784772] Starting dynamic subtest: pipe-A-eDP-1-ctm [289.182480] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.407s) [289.993588] Starting dynamic subtest: pipe-B-eDP-1-gamma [290.711547] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.723s) [290.721442] Starting dynamic subtest: pipe-B-eDP-1-degamma [292.132676] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.422s) [292.141556] Starting dynamic subtest: pipe-B-eDP-1-ctm [293.564769] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.431s) [294.367725] Starting dynamic subtest: pipe-C-eDP-1-gamma [295.044935] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.682s) [295.053402] Starting dynamic subtest: pipe-C-eDP-1-degamma [296.401721] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.355s) [296.410389] Starting dynamic subtest: pipe-C-eDP-1-ctm [297.820550] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.419s) [298.555358] Starting dynamic subtest: pipe-D-eDP-1-gamma [299.207987] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.657s) [299.217454] Starting dynamic subtest: pipe-D-eDP-1-degamma [300.607303] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.401s) [300.615316] Starting dynamic subtest: pipe-D-eDP-1-ctm [302.056526] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.448s) [302.058830] Subtest deep-color: SUCCESS (17.552s) [302.892585] [080/130] (717s left) kms_universal_plane (universal-plane-functional) [302.991264] Starting subtest: universal-plane-functional [302.993678] Starting dynamic subtest: pipe-A-eDP-1 [306.817301] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.823s) [306.825857] Starting dynamic subtest: pipe-B-eDP-1 [311.305559] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.485s) [311.313782] Starting dynamic subtest: pipe-C-eDP-1 [315.545262] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.242s) [315.553290] Starting dynamic subtest: pipe-D-eDP-1 [319.718128] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.168s) [319.720541] Subtest universal-plane-functional: SUCCESS (16.725s) [320.510657] [081/130] (699s left) kms_properties (plane-properties-atomic) [320.609327] Starting subtest: plane-properties-atomic [320.611705] Starting dynamic subtest: pipe-A-eDP-1 [321.198701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s) [321.206701] Starting dynamic subtest: pipe-B-eDP-1 [322.482719] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.282s) [322.491226] Starting dynamic subtest: pipe-C-eDP-1 [323.699155] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s) [323.707102] Starting dynamic subtest: pipe-D-eDP-1 [324.929941] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s) [324.932490] Subtest plane-properties-atomic: SUCCESS (4.319s) [325.709706] [082/130] (694s left) perf (blocking) [325.815702] Starting subtest: blocking [325.818025] Starting dynamic subtest: 0-rcs0 [335.853074] Dynamic subtest 0-rcs0: SUCCESS (10.037s) [335.861115] Starting dynamic subtest: 1-vcs0 [345.874395] Dynamic subtest 1-vcs0: SUCCESS (10.021s) [345.876820] Subtest blocking: SUCCESS (20.060s) [345.916217] [083/130] (674s left) gem_exec_balancer (full) [345.987472] Starting subtest: full [350.627825] Subtest full: SUCCESS (4.640s) [350.951633] [084/130] (669s left) gem_exec_fence (basic-busy-all) [351.011876] Starting subtest: basic-busy-all [351.089337] Subtest basic-busy-all: SUCCESS (0.078s) [352.998924] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true [353.002355] [085/130] (667s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [353.098130] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [353.100484] Starting dynamic subtest: pipe-A-eDP-1 [353.109581] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [353.118617] Starting dynamic subtest: pipe-B-eDP-1 [353.126870] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [353.134728] Starting dynamic subtest: pipe-C-eDP-1 [353.143631] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [353.151779] Starting dynamic subtest: pipe-D-eDP-1 [353.160660] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [353.165092] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [355.255663] [086/130] (665s left) kms_cursor_crc (cursor-sliding-64x21) [355.440638] Starting subtest: cursor-sliding-64x21 [355.480172] Subtest cursor-sliding-64x21: SKIP (0.035s) [355.725434] [087/130] (664s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [355.821797] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [355.824028] Starting dynamic subtest: pipe-A-default-mode [356.111076] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [356.115654] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.285s) [356.887543] [088/130] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [356.988795] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [356.993160] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [357.086567] [089/130] (663s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [357.186632] Starting subtest: fbcpsr-stridechange [361.258988] Subtest fbcpsr-stridechange: SUCCESS (4.075s) [361.387424] [090/130] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [361.484021] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [361.488081] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [361.595517] [091/130] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [361.694692] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [361.698832] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [361.807345] [092/130] (659s left) syncobj_basic (bad-flags-handle-to-fd) [361.865546] Starting subtest: bad-flags-handle-to-fd [361.867873] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [361.965209] [093/130] (658s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [362.066055] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [362.077848] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s) [362.168910] [094/130] (658s left) gem_exec_schedule (preempt-queue-chain) [362.249165] Subtest preempt-queue-chain: SKIP (0.000s) [362.535110] [095/130] (658s left) gem_exec_reloc (basic-cpu-wc) [362.600863] Subtest basic-cpu-wc: SKIP (0.000s) [362.665524] [096/130] (658s left) perf (gen8-unprivileged-single-ctx-counters) [362.751562] Starting subtest: gen8-unprivileged-single-ctx-counters [362.756110] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [362.792548] [097/130] (658s left) syncobj_timeline (invalid-query-zero-handles) [362.849772] Starting subtest: invalid-query-zero-handles [362.852592] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [362.963067] [098/130] (658s left) kms_frontbuffer_tracking (fbc-tiling-linear) [363.068235] Starting subtest: fbc-tiling-linear [365.799342] Subtest fbc-tiling-linear: SUCCESS (2.735s) [365.952834] [099/130] (655s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [366.060577] Starting subtest: psr-indfb-scaledprimary [369.713212] Subtest psr-indfb-scaledprimary: SUCCESS (3.653s) [369.865019] [100/130] (651s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [369.972071] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [369.974250] Starting dynamic subtest: pipe-A-eDP-1 [369.996103] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [370.006286] Starting dynamic subtest: pipe-B-eDP-1 [370.027588] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [370.034809] Starting dynamic subtest: pipe-C-eDP-1 [370.056761] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [370.063961] Starting dynamic subtest: pipe-D-eDP-1 [370.086216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [370.090324] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s) [372.168170] [101/130] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [372.270066] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [372.274234] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [372.356703] [102/130] (648s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [372.477203] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [372.627812] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.153s) [372.754899] [103/130] (648s left) api_intel_bb (object-reloc-keep-cache) [372.811049] Starting subtest: object-reloc-keep-cache [372.815521] Subtest object-reloc-keep-cache: SKIP (0.003s) [372.895756] [104/130] (648s left) gem_exec_schedule (u-submit-early-slice) [372.966651] Starting subtest: u-submit-early-slice [372.969016] Starting dynamic subtest: rcs0 [373.002268] Dynamic subtest rcs0: SUCCESS (0.043s) [373.012851] Starting dynamic subtest: bcs0 [373.039918] Dynamic subtest bcs0: SUCCESS (0.037s) [373.050014] Starting dynamic subtest: vcs0 [373.078143] Dynamic subtest vcs0: SUCCESS (0.038s) [373.087070] Starting dynamic subtest: vcs1 [373.115202] Dynamic subtest vcs1: SUCCESS (0.037s) [373.124594] Starting dynamic subtest: vecs0 [373.153336] Dynamic subtest vecs0: SUCCESS (0.038s) [373.161271] Starting dynamic subtest: ccs0 [373.199166] Dynamic subtest ccs0: SUCCESS (0.045s) [373.201413] Subtest u-submit-early-slice: SUCCESS (0.241s) [375.026537] [105/130] (646s left) syncobj_timeline (signal-array) [375.073653] Starting subtest: signal-array [375.076138] Subtest signal-array: SUCCESS (0.000s) [375.167041] [106/130] (646s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [375.291396] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [375.295842] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [375.385543] [107/130] (645s left) kms_plane_alpha_blend (constant-alpha-min) [375.487137] Starting subtest: constant-alpha-min [375.891682] Starting dynamic subtest: pipe-A-eDP-1 [376.590428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s) [376.601078] Starting dynamic subtest: pipe-D-eDP-1 [378.010767] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.419s) [378.013209] Subtest constant-alpha-min: SUCCESS (2.522s) [378.817980] [108/130] (642s left) syncobj_wait (wait-for-submit-delayed-submit) [378.877637] Starting subtest: wait-for-submit-delayed-submit [378.981750] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [379.056435] [109/130] (642s left) kms_big_fb (linear-8bpp-rotate-0) [379.173284] Starting subtest: linear-8bpp-rotate-0 [380.338953] Subtest linear-8bpp-rotate-0: SUCCESS (1.167s) [380.534999] [110/130] (640s left) kms_psr (psr2-sprite-mmap-gtt) [380.632929] Starting subtest: psr2-sprite-mmap-gtt [380.634774] Starting dynamic subtest: eDP-1 [382.118178] Dynamic subtest eDP-1: SKIP (1.480s) [382.123077] Subtest psr2-sprite-mmap-gtt: SKIP (1.482s) [382.264581] [111/130] (639s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [382.367361] Starting subtest: yf-tiled-8bpp-rotate-90 [382.371405] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [382.452831] [112/130] (639s left) sw_sync (sync_multi_consumer_producer) [382.492099] Starting subtest: sync_multi_consumer_producer [382.798767] Subtest sync_multi_consumer_producer: SUCCESS (0.311s) [382.853405] [113/130] (638s left) gem_exec_whisper (basic-normal-all) [382.923828] Starting subtest: basic-normal-all [385.372412] Subtest basic-normal-all: SUCCESS (2.446s) [385.549708] [114/130] (636s left) gem_softpin (evict-single-offset) [385.615374] Starting subtest: evict-single-offset [411.947471] Subtest evict-single-offset: SUCCESS (26.330s) [412.026118] [115/130] (609s left) sw_sync (alloc_fence_invalid_timeline) [412.097298] Starting subtest: alloc_fence_invalid_timeline [412.099802] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [412.155456] [116/130] (609s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [412.211822] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [412.214199] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [412.325286] [117/130] (609s left) kms_flip (2x-flip-vs-rmfb-interruptible) [412.430841] Starting subtest: 2x-flip-vs-rmfb-interruptible [412.442532] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s) [412.512271] [118/130] (609s left) kms_chamelium_edid (hdmi-mode-timings) [412.902199] Subtest hdmi-mode-timings: SKIP (0.000s) [413.738970] [119/130] (608s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [413.853880] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [415.066490] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.214s) [415.238315] [120/130] (606s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [415.343318] Starting subtest: 2x-wf_vblank-ts-check-interruptible [415.355622] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s) [415.472192] [121/130] (606s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [415.531618] Starting subtest: etime-multi-wait-available-unsubmitted [415.638191] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s) [415.706878] [122/130] (606s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [415.807149] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [415.809404] Starting dynamic subtest: pipe-A-eDP-1 [415.834522] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [415.845144] Starting dynamic subtest: pipe-B-eDP-1 [415.868113] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [415.875675] Starting dynamic subtest: pipe-C-eDP-1 [415.899144] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [415.907192] Starting dynamic subtest: pipe-D-eDP-1 [415.931225] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [415.935603] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s) [417.922474] [123/130] (604s left) kms_big_fb (y-tiled-8bpp-rotate-180) [418.032146] Starting subtest: y-tiled-8bpp-rotate-180 [418.036531] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [418.145125] [124/130] (603s left) kms_plane (plane-panning-bottom-right-suspend) [418.255736] Starting subtest: plane-panning-bottom-right-suspend [418.258055] Starting dynamic subtest: pipe-A [436.140232] Dynamic subtest pipe-A: SUCCESS (2.817s) [436.148974] Starting dynamic subtest: pipe-B [454.064830] Dynamic subtest pipe-B: SUCCESS (3.316s) [454.067200] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.136s) [454.916411] [125/130] (596s left) gem_exec_fence (submit-chain) [455.103158] Starting subtest: submit-chain [455.119986] Subtest submit-chain: SUCCESS (0.017s) [456.698456] [126/130] (594s left) syncobj_wait (wait-all-delayed-signal) [456.762048] Starting subtest: wait-all-delayed-signal [456.864685] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [456.933914] [127/130] (594s left) api_intel_bb (crc32) [456.990523] Starting subtest: crc32 [456.992840] Starting dynamic subtest: rcs0-smem0 [457.278493] Dynamic subtest rcs0-smem0: SUCCESS (0.289s) [457.290372] Starting dynamic subtest: bcs0-smem0 [457.599192] Dynamic subtest bcs0-smem0: SUCCESS (0.320s) [457.611555] Starting dynamic subtest: vcs0-smem0 [457.951017] Dynamic subtest vcs0-smem0: SUCCESS (0.352s) [457.963072] Starting dynamic subtest: vcs1-smem0 [458.267156] Dynamic subtest vcs1-smem0: SUCCESS (0.316s) [458.280305] Starting dynamic subtest: vecs0-smem0 [458.596968] Dynamic subtest vecs0-smem0: SUCCESS (0.330s) [458.608043] Starting dynamic subtest: ccs0-smem0 [458.935895] Dynamic subtest ccs0-smem0: SUCCESS (0.339s) [458.938541] Subtest crc32: SUCCESS (1.963s) [459.088408] [128/130] (592s left) kms_cursor_crc (cursor-offscreen-256x85) [459.318169] Starting subtest: cursor-offscreen-256x85 [459.357560] Subtest cursor-offscreen-256x85: SKIP (0.034s) [459.523229] [129/130] (592s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [459.580064] Starting subtest: x-tiled-to-vebox-yf-tiled [459.584537] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [459.756378] [130/130] (592s left) gem_mmap_gtt (basic-read) [459.817335] Subtest basic-read: SKIP (0.000s) [459.873200] Closing watchdogs Done.