[61.431892] Initializing watchdogs [61.431942] /dev/watchdog0 [61.446350] [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] [61.450492] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.452846] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.456341] [001/156] (960s left) prime_vgem (basic-fence-read) [61.592460] Starting subtest: basic-fence-read [61.600272] Subtest basic-fence-read: SKIP (0.006s) [61.719621] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [61.722822] [002/156] (960s left) core_setmaster (master-drop-set-shared-fd) [61.802549] Starting subtest: master-drop-set-shared-fd [61.812423] Subtest master-drop-set-shared-fd: SUCCESS (0.011s) [61.849450] [003/156] (960s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [61.945791] Starting subtest: plane-downscale-factor-0-5-with-modifiers [61.948049] Starting dynamic subtest: pipe-A [61.970091] Dynamic subtest pipe-A: SKIP (0.020s) [61.979908] Starting dynamic subtest: pipe-B [62.003344] Dynamic subtest pipe-B: SKIP (0.033s) [62.011128] Starting dynamic subtest: pipe-C [62.035592] Dynamic subtest pipe-C: SKIP (0.032s) [62.042961] Starting dynamic subtest: pipe-D [62.067056] Dynamic subtest pipe-D: SKIP (0.032s) [62.070982] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.118s) [62.157175] [004/156] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [62.249741] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [69.250765] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.042s) [69.375564] [005/156] (952s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [69.479081] Starting subtest: nonblocking-crc-frame-sequence [69.480997] Starting dynamic subtest: pipe-A-eDP-1 [70.216601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s) [70.226616] Starting dynamic subtest: pipe-B-eDP-1 [71.648982] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s) [71.658068] Starting dynamic subtest: pipe-C-eDP-1 [73.039172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s) [73.049774] Starting dynamic subtest: pipe-D-eDP-1 [74.433957] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s) [74.436721] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.968s) [75.251936] [006/156] (946s left) gem_exec_schedule (fairslice-all) [75.322679] Starting subtest: fairslice-all [77.417381] Subtest fairslice-all: SUCCESS (2.068s) [79.382766] [007/156] (942s left) syncobj_timeline (invalid-transfer-illegal-handle) [79.430720] Starting subtest: invalid-transfer-illegal-handle [79.432635] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [79.519976] [008/156] (942s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [79.590021] Starting subtest: x-tiled-to-vebox-y-tiled [79.595073] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [79.790978] [009/156] (942s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff) [79.897831] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff [79.902343] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [80.016807] [010/156] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [80.124461] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [80.128662] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [80.220872] [011/156] (942s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [80.324831] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [80.329490] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [80.421073] [012/156] (941s left) gem_exec_balancer (parallel-keep-submit-fence) [80.681363] Starting subtest: parallel-keep-submit-fence [81.766506] Subtest parallel-keep-submit-fence: SUCCESS (1.085s) [81.889989] [013/156] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite) [81.982960] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite [81.987598] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [82.080399] [014/156] (940s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-msflip-blt) [82.169118] Starting subtest: hdr-1p-primscrn-indfb-msflip-blt [82.173271] Subtest hdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [82.275583] [015/156] (940s left) gem_lmem_swapping (verify-ccs) [82.314567] Subtest verify-ccs: SKIP (0.000s) [82.356365] [016/156] (940s left) syncobj_wait (multi-wait-all-for-submit-signaled) [82.420091] Starting subtest: multi-wait-all-for-submit-signaled [82.421964] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [82.522324] [017/156] (940s left) prime_mmap (test_dup) [82.578929] Starting subtest: test_dup [82.581248] Starting dynamic subtest: test_dup-smem [82.608352] Dynamic subtest test_dup-smem: SUCCESS (0.031s) [82.610852] Subtest test_dup: SUCCESS (0.031s) [82.679162] [018/156] (939s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [82.802483] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [83.794853] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.993s) [84.668205] [019/156] (938s left) gem_huc_copy (huc-copy) [84.729839] Starting subtest: huc-copy [84.734608] Subtest huc-copy: SUCCESS (0.003s) [84.850824] [020/156] (937s left) kms_frontbuffer_tracking (fbc-tiling-linear) [84.949261] Starting subtest: fbc-tiling-linear [88.747227] Subtest fbc-tiling-linear: SUCCESS (3.802s) [89.920113] [021/156] (932s left) prime_vgem (basic-write) [89.999949] Starting subtest: basic-write [90.007874] Subtest basic-write: SKIP (0.006s) [90.111981] [022/156] (932s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render) [90.209372] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render [90.214029] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [90.319968] [023/156] (932s left) gem_wait (write-wait) [90.392544] Starting subtest: write-wait [90.395100] Starting dynamic subtest: all-engines [91.502944] Dynamic subtest all-engines: SUCCESS (1.110s) [91.519464] Starting dynamic subtest: rcs0 [92.558672] Dynamic subtest rcs0: SUCCESS (1.054s) [92.575103] Starting dynamic subtest: bcs0 [93.617341] Dynamic subtest bcs0: SUCCESS (1.056s) [93.632757] Starting dynamic subtest: vcs0 [94.669503] Dynamic subtest vcs0: SUCCESS (1.052s) [94.685950] Starting dynamic subtest: vcs1 [95.724066] Dynamic subtest vcs1: SUCCESS (1.053s) [95.739698] Starting dynamic subtest: vecs0 [96.777411] Dynamic subtest vecs0: SUCCESS (1.053s) [96.792515] Starting dynamic subtest: ccs0 [97.834249] Dynamic subtest ccs0: SUCCESS (1.055s) [97.836867] Subtest write-wait: SUCCESS (7.441s) [98.029360] [024/156] (924s left) kms_addfb_basic (bo-too-small) [98.132324] Starting subtest: bo-too-small [98.134202] Subtest bo-too-small: SUCCESS (0.000s) [98.244282] [025/156] (924s left) kms_psr (psr-primary-page-flip) [98.340853] Starting subtest: psr-primary-page-flip [98.343119] Starting dynamic subtest: eDP-1 [100.088068] Dynamic subtest eDP-1: SUCCESS (1.746s) [100.090797] Subtest psr-primary-page-flip: SUCCESS (1.747s) [100.948364] [026/156] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [101.046781] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [101.051104] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [101.148919] [027/156] (921s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite) [101.253147] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite [101.257118] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [101.342170] [028/156] (921s left) gem_mmap_gtt (big-copy-odd) [101.394141] Subtest big-copy-odd: SKIP (0.000s) [101.459053] [029/156] (921s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-onoff) [101.558423] Starting subtest: hdr-2p-scndscrn-cur-indfb-onoff [101.562408] Subtest hdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [101.648551] [030/156] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [101.753644] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [106.099485] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.352s) [107.263130] [031/156] (915s left) kms_atomic_transition (modeset-transition-fencing) [107.349297] Starting subtest: modeset-transition-fencing [107.351260] Starting dynamic subtest: 1x-outputs [118.485901] Dynamic subtest 1x-outputs: SUCCESS (11.137s) [118.488374] Subtest modeset-transition-fencing: SUCCESS (11.138s) [119.341946] [032/156] (903s left) gem_exec_reloc (basic-cpu-read) [119.406520] Subtest basic-cpu-read: SKIP (0.000s) [119.479844] [033/156] (903s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc) [119.586086] Starting subtest: fbchdr-rgb565-draw-mmap-wc [119.590229] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s) [119.683767] [034/156] (903s left) kms_chamelium_frames (dp-crc-multiple) [120.072993] Subtest dp-crc-multiple: SKIP (0.000s) [120.857285] [035/156] (902s left) fbdev (pan) [120.894186] Starting subtest: pan [120.916418] Subtest pan: SUCCESS (0.026s) [121.002159] [036/156] (902s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [121.097602] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [121.101719] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [121.193935] [037/156] (902s left) i915_pm_rpm (system-suspend) [123.531784] Starting subtest: system-suspend [142.042668] Subtest system-suspend: SUCCESS (3.024s) [142.436659] [038/156] (881s left) kms_psr (fbc-psr2-cursor-blt) [142.544503] Starting subtest: fbc-psr2-cursor-blt [142.546837] Starting dynamic subtest: eDP-1 [142.551223] Dynamic subtest eDP-1: SKIP (0.000s) [142.555913] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [142.615948] [039/156] (880s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt) [142.704931] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt [142.709381] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [142.789562] [040/156] (880s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [142.890443] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [142.892772] Starting dynamic subtest: pipe-A-eDP-1 [142.982497] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [142.994735] Starting dynamic subtest: pipe-B-eDP-1 [144.173674] Dynamic subtest pipe-B-eDP-1: SKIP (1.215s) [144.178597] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.316s) [145.355579] [041/156] (878s left) i915_selftest (live) [149.919046] Starting subtest: live [149.921434] Starting dynamic subtest: sanitycheck [154.253044] Dynamic subtest sanitycheck: SUCCESS (4.368s) [154.262142] Starting dynamic subtest: uncore [158.655124] Dynamic subtest uncore: SUCCESS (4.419s) [158.665210] Starting dynamic subtest: workarounds [161.780834] Dynamic subtest workarounds: SUCCESS (3.133s) [161.790929] Starting dynamic subtest: gt_engines [166.389394] Dynamic subtest gt_engines: SUCCESS (4.616s) [166.398601] Starting dynamic subtest: gt_timelines [184.100812] Dynamic subtest gt_timelines: SUCCESS (17.714s) [184.110606] Starting dynamic subtest: gt_contexts [188.440654] Dynamic subtest gt_contexts: SUCCESS (4.339s) [188.450825] Starting dynamic subtest: gt_lrc [192.772997] Dynamic subtest gt_lrc: SUCCESS (4.331s) [192.783262] Starting dynamic subtest: gt_mocs [195.717231] Dynamic subtest gt_mocs: SUCCESS (2.943s) [195.726136] Starting dynamic subtest: gt_pm [202.812645] Dynamic subtest gt_pm: SUCCESS (7.095s) [202.821430] Starting dynamic subtest: gt_heartbeat [207.147712] Dynamic subtest gt_heartbeat: SUCCESS (4.334s) [207.158885] Starting dynamic subtest: gt_tlb [216.448161] Dynamic subtest gt_tlb: SUCCESS (9.302s) [216.458176] Starting dynamic subtest: requests [227.974359] Dynamic subtest requests: SUCCESS (11.529s) [227.984116] Starting dynamic subtest: migrate [235.703889] Dynamic subtest migrate: SUCCESS (7.732s) [235.714683] Starting dynamic subtest: active [240.090195] Dynamic subtest active: SUCCESS (4.383s) [240.099995] Starting dynamic subtest: objects [244.733307] Dynamic subtest objects: SUCCESS (4.640s) [244.743160] Starting dynamic subtest: mman [249.485021] Dynamic subtest mman: SUCCESS (4.748s) [249.497412] Starting dynamic subtest: dmabuf [253.834190] Dynamic subtest dmabuf: SUCCESS (4.346s) [253.843803] Starting dynamic subtest: vma [258.223194] Dynamic subtest vma: SUCCESS (4.388s) [258.231923] Starting dynamic subtest: coherency [263.557145] Dynamic subtest coherency: SUCCESS (5.330s) [263.567228] Starting dynamic subtest: gtt [275.395257] Dynamic subtest gtt: SUCCESS (11.836s) [275.406375] Starting dynamic subtest: gem [283.497831] Dynamic subtest gem: SUCCESS (8.101s) [283.508544] Starting dynamic subtest: evict [288.906174] Dynamic subtest evict: SUCCESS (5.409s) [288.916559] Starting dynamic subtest: hugepages [299.661464] Dynamic subtest hugepages: SUCCESS (10.754s) [299.670874] Starting dynamic subtest: gem_contexts [328.261525] Dynamic subtest gem_contexts: SUCCESS (28.605s) [328.271565] Starting dynamic subtest: client [332.622670] Dynamic subtest client: SUCCESS (4.361s) [332.632889] Starting dynamic subtest: gem_migrate [335.316403] Dynamic subtest gem_migrate: SUCCESS (2.694s) [335.325608] Starting dynamic subtest: reset [339.672530] Dynamic subtest reset: SUCCESS (4.356s) [339.682880] Starting dynamic subtest: memory_region [344.007228] Dynamic subtest memory_region: SUCCESS (4.335s) [344.021247] Starting dynamic subtest: hangcheck [357.303082] Dynamic subtest hangcheck: SUCCESS (13.297s) [357.314288] Starting dynamic subtest: execlists [361.587793] Dynamic subtest execlists: SUCCESS (4.284s) [361.598450] Starting dynamic subtest: ring_submission [365.875436] Dynamic subtest ring_submission: SUCCESS (4.286s) [365.885901] Starting dynamic subtest: perf [370.247201] Dynamic subtest perf: SUCCESS (4.368s) [370.258119] Starting dynamic subtest: slpc [384.277550] Dynamic subtest slpc: SUCCESS (14.023s) [384.287179] Starting dynamic subtest: guc [388.182873] Dynamic subtest guc: SUCCESS (3.903s) [388.190650] Starting dynamic subtest: guc_multi_lrc [392.503162] Dynamic subtest guc_multi_lrc: SUCCESS (4.318s) [392.513728] Starting dynamic subtest: guc_hang [397.411243] Dynamic subtest guc_hang: SUCCESS (4.906s) [397.421693] Starting dynamic subtest: late_gt_pm [400.217315] Dynamic subtest late_gt_pm: SUCCESS (2.803s) [400.220258] Subtest live: SUCCESS (250.386s) [400.266659] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [400.267495] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [400.270892] [042/156] (623s left) syncobj_timeline (etime-single-wait-all-submitted) [401.820016] Starting subtest: etime-single-wait-all-submitted [401.926849] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s) [401.964262] [FACT syncobj_timeline (etime-single-wait-all-submitted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [401.965875] [FACT syncobj_timeline (etime-single-wait-all-submitted)] new: kernel.kmod_is_loaded.i915: true [401.969744] [043/156] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [402.074652] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [409.383972] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.312s) [409.517434] [044/156] (614s left) gem_exec_schedule (u-semaphore-codependency) [409.591024] Starting subtest: u-semaphore-codependency [409.603903] Subtest u-semaphore-codependency: SUCCESS (0.016s) [409.944747] [045/156] (613s left) gem_softpin (evict-snoop) [409.998228] Starting subtest: evict-snoop [410.002942] Subtest evict-snoop: SKIP (0.000s) [410.130840] [046/156] (613s left) drm_read (short-buffer-nonblock) [410.275378] Starting subtest: short-buffer-nonblock [410.277730] Subtest short-buffer-nonblock: SUCCESS (0.000s) [410.402260] [047/156] (613s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [410.496727] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [410.501264] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [410.622450] [048/156] (613s left) kms_getfb (getfb2-accept-nv12) [410.719392] Starting subtest: getfb2-accept-nv12 [410.721656] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [410.842591] [049/156] (613s left) kms_cursor_crc (cursor-offscreen-256x85) [411.110265] Starting subtest: cursor-offscreen-256x85 [411.162259] Subtest cursor-offscreen-256x85: SKIP (0.048s) [411.326039] [050/156] (612s left) i915_hangman (gt-engine-error) [411.387498] Starting subtest: gt-engine-error [411.389109] Starting dynamic subtest: rcs0 [412.784970] Dynamic subtest rcs0: SUCCESS (1.396s) [412.799371] Starting dynamic subtest: bcs0 [414.762252] Dynamic subtest bcs0: SUCCESS (1.974s) [414.774440] Starting dynamic subtest: vcs0 [416.747538] Dynamic subtest vcs0: SUCCESS (1.982s) [416.758220] Starting dynamic subtest: vcs1 [418.731879] Dynamic subtest vcs1: SUCCESS (1.982s) [418.745042] Starting dynamic subtest: vecs0 [420.776924] Dynamic subtest vecs0: SUCCESS (2.042s) [420.790590] Starting dynamic subtest: ccs0 [422.761782] Dynamic subtest ccs0: SUCCESS (1.982s) [422.764771] Subtest gt-engine-error: SUCCESS (11.374s) [422.853500] [051/156] (601s left) gem_ppgtt (shrink-vs-evict-any) [422.917351] Starting subtest: shrink-vs-evict-any [428.828126] Subtest shrink-vs-evict-any: SUCCESS (5.856s) [428.880847] [052/156] (595s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [428.985424] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [428.990008] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [429.072165] [053/156] (595s left) syncobj_wait (invalid-reset-zero-handles) [429.132626] Starting subtest: invalid-reset-zero-handles [429.134492] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [429.223169] [054/156] (594s left) gem_ctx_shared (q-independent) [429.289512] Starting subtest: Q-independent [429.291915] Starting dynamic subtest: rcs0 [429.357284] Dynamic subtest rcs0: SUCCESS (0.067s) [429.369531] Starting dynamic subtest: vcs0 [429.404992] Dynamic subtest vcs0: SUCCESS (0.047s) [429.416234] Starting dynamic subtest: vcs1 [429.441472] Dynamic subtest vcs1: SUCCESS (0.036s) [429.451278] Starting dynamic subtest: vecs0 [429.481386] Dynamic subtest vecs0: SUCCESS (0.039s) [429.491540] Starting dynamic subtest: ccs0 [429.521965] Dynamic subtest ccs0: SUCCESS (0.040s) [429.524324] Subtest Q-independent: SUCCESS (0.233s) [430.898021] [055/156] (593s left) kms_draw_crc (draw-method-mmap-gtt) [430.988786] Starting subtest: draw-method-mmap-gtt [430.993110] Subtest draw-method-mmap-gtt: SKIP (0.000s) [431.090374] [056/156] (593s left) i915_drm_fdinfo (virtual-busy) [431.128546] Starting subtest: virtual-busy [431.132685] Subtest virtual-busy: SKIP (0.000s) [431.189095] [057/156] (593s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [431.280529] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [431.282741] Starting dynamic subtest: pipe-A-eDP-1 [432.491375] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.212s) [432.501590] Starting dynamic subtest: pipe-B-eDP-1 [434.852639] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.360s) [434.862655] Starting dynamic subtest: pipe-C-eDP-1 [437.180794] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.327s) [437.190790] Starting dynamic subtest: pipe-D-eDP-1 [439.471584] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.289s) [439.474365] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.194s) [440.634866] [058/156] (583s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [440.746986] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [441.549034] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s) [441.726213] [059/156] (582s left) gem_exec_whisper (basic-fds-forked-all) [441.794757] Starting subtest: basic-fds-forked-all [461.741916] Subtest basic-fds-forked-all: SUCCESS (19.949s) [461.945143] [060/156] (562s left) syncobj_timeline (single-wait-for-submit-signaled) [462.003720] Starting subtest: single-wait-for-submit-signaled [462.006029] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s) [462.116263] [061/156] (562s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu) [462.227024] Starting subtest: hdr-rgb101010-draw-mmap-cpu [462.231562] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [462.315541] [062/156] (562s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [462.409096] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [462.411873] Starting dynamic subtest: pipe-A-eDP-1 [462.434754] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [462.445244] Starting dynamic subtest: pipe-B-eDP-1 [462.466962] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [462.476514] Starting dynamic subtest: pipe-C-eDP-1 [462.498519] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [462.508127] Starting dynamic subtest: pipe-D-eDP-1 [462.530512] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [462.534578] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [464.732257] [063/156] (559s left) kms_pm_rpm (modeset-pc8-residency-stress) [466.872409] Starting subtest: modeset-pc8-residency-stress [466.877359] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [467.265612] [064/156] (557s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [467.368157] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [467.370402] Starting dynamic subtest: pipe-A-default-mode [470.101817] Dynamic subtest pipe-A-default-mode: SUCCESS (2.734s) [470.104269] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.735s) [470.942692] [065/156] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [471.038353] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [471.042816] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [471.134418] [066/156] (553s left) syncobj_eventfd (timeline-wait-before-signal) [471.190237] Starting subtest: timeline-wait-before-signal [471.220351] Subtest timeline-wait-before-signal: SUCCESS (0.031s) [471.299300] [067/156] (553s left) kms_pm_backlight (fade-with-suspend) [471.392634] Starting subtest: fade-with-suspend [488.196324] Starting dynamic subtest: eDP-1 [491.216143] Dynamic subtest eDP-1: SUCCESS (3.082s) [491.218473] Subtest fade-with-suspend: SUCCESS (5.054s) [492.029316] [068/156] (532s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc) [492.150028] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc [492.154226] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [492.257862] [069/156] (532s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff) [492.348882] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff [492.353143] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [492.471688] [070/156] (532s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [492.563713] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [492.567938] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [492.650776] [071/156] (532s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [492.744456] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu [492.748707] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [492.842722] [072/156] (532s left) kms_flip (busy-flip) [492.931133] Starting subtest: busy-flip [492.933130] Starting dynamic subtest: A-eDP1 [494.597303] Dynamic subtest A-eDP1: SUCCESS (1.688s) [494.609807] Starting dynamic subtest: B-eDP1 [496.308780] Dynamic subtest B-eDP1: SUCCESS (1.728s) [496.319761] Starting dynamic subtest: C-eDP1 [498.010585] Dynamic subtest C-eDP1: SUCCESS (1.715s) [498.021740] Starting dynamic subtest: D-eDP1 [499.729946] Dynamic subtest D-eDP1: SUCCESS (1.730s) [499.735183] Subtest busy-flip: SUCCESS (6.874s) [500.878728] [073/156] (524s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [500.971371] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [500.975402] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [501.075088] [074/156] (523s left) kms_content_protection (mei-interface) [501.211615] Starting subtest: mei-interface [501.216139] Subtest mei-interface: SKIP (0.001s) [501.335574] [075/156] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [501.426894] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [501.430812] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [501.535798] [076/156] (523s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc) [501.631230] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc [501.635349] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [501.738455] [077/156] (523s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [501.839447] Starting subtest: fbcpsr-slowdraw [527.051518] Subtest fbcpsr-slowdraw: SUCCESS (25.253s) [527.213372] [078/156] (497s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [527.267030] Starting subtest: multi-wait-for-submit-available-submitted [527.269392] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [527.365649] [079/156] (497s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [527.450555] Starting subtest: primary-x-tiled-reflect-x-180 [534.477182] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.027s) [535.640944] [080/156] (489s left) gem_exec_flush (basic-wb-prw-default) [535.704623] Starting subtest: basic-wb-prw-default [541.191820] Subtest basic-wb-prw-default: SUCCESS (5.485s) [541.376601] [081/156] (483s left) gem_mmap_gtt (medium-copy-xy) [541.427520] Subtest medium-copy-XY: SKIP (0.000s) [541.484033] [082/156] (483s left) kms_color (deep-color) [541.573306] Starting subtest: deep-color [542.630589] Starting dynamic subtest: pipe-A-eDP-1-gamma [543.333353] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.704s) [543.347629] Starting dynamic subtest: pipe-A-eDP-1-degamma [544.845212] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.509s) [544.859186] Starting dynamic subtest: pipe-A-eDP-1-ctm [546.267638] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.425s) [547.041133] Starting dynamic subtest: pipe-B-eDP-1-gamma [547.753130] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.720s) [547.763734] Starting dynamic subtest: pipe-B-eDP-1-degamma [549.226697] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.475s) [549.237790] Starting dynamic subtest: pipe-B-eDP-1-ctm [550.648984] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.422s) [551.434795] Starting dynamic subtest: pipe-C-eDP-1-gamma [552.117886] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.691s) [552.128724] Starting dynamic subtest: pipe-C-eDP-1-degamma [553.490870] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.372s) [553.501179] Starting dynamic subtest: pipe-C-eDP-1-ctm [554.915755] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.427s) [555.741215] Starting dynamic subtest: pipe-D-eDP-1-gamma [556.441043] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.714s) [556.451247] Starting dynamic subtest: pipe-D-eDP-1-degamma [557.891673] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.450s) [557.903481] Starting dynamic subtest: pipe-D-eDP-1-ctm [559.322807] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.428s) [559.325360] Subtest deep-color: SUCCESS (17.752s) [560.174182] [083/156] (465s left) gem_exec_params (invalid-bsd2-flag-on-blt) [560.233420] Starting subtest: invalid-bsd2-flag-on-blt [560.235951] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [560.333561] [084/156] (465s left) kms_frontbuffer_tracking (fbc-suspend) [560.435910] Starting subtest: fbc-suspend [598.634084] Subtest fbc-suspend: SUCCESS (7.488s) [599.803434] [085/156] (425s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [599.860350] Starting subtest: multi-wait-all-for-submit-unsubmitted [599.964571] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s) [600.040734] [086/156] (425s left) gem_tiled_partial_pwrite_pread (writes) [600.101967] Subtest writes: SKIP (0.000s) [600.181484] [087/156] (425s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-plflip-blt) [600.276328] Starting subtest: psrhdr-1p-primscrn-indfb-plflip-blt [600.280748] Subtest psrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [600.390336] [088/156] (425s left) kms_psr (fbc-pr-sprite-mmap-cpu) [600.471183] Starting subtest: fbc-pr-sprite-mmap-cpu [600.475253] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [600.557485] [089/156] (425s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [600.617970] Starting subtest: y-tiled-to-vebox-x-tiled [600.622244] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [600.799790] [090/156] (424s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [600.899362] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc [600.903267] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [601.006737] [091/156] (424s left) prime_vgem (fence-write-hang) [601.092025] Subtest fence-write-hang: SKIP (0.000s) [601.181281] [092/156] (424s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [601.564407] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [602.374491] [093/156] (423s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [602.470489] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [602.474766] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [602.558931] [094/156] (423s left) gem_exec_fence (syncobj-import) [603.023868] Starting subtest: syncobj-import [603.029785] Subtest syncobj-import: SUCCESS (0.005s) [604.481000] [095/156] (421s left) kms_big_fb (linear-64bpp-rotate-270) [604.592381] Starting subtest: linear-64bpp-rotate-270 [604.612373] Subtest linear-64bpp-rotate-270: SKIP (0.020s) [604.736406] [096/156] (421s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [604.838152] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [604.842783] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [604.958492] [097/156] (420s left) perf (create-destroy-userspace-config) [605.075770] Starting subtest: create-destroy-userspace-config [605.100092] Subtest create-destroy-userspace-config: SUCCESS (0.023s) [605.138117] [098/156] (420s left) perf_pmu (busy-idle) [605.175202] Starting subtest: busy-idle [605.177481] Starting dynamic subtest: rcs0 [605.874821] Dynamic subtest rcs0: SUCCESS (0.709s) [605.886749] Starting dynamic subtest: bcs0 [606.544251] Dynamic subtest bcs0: SUCCESS (0.671s) [606.556310] Starting dynamic subtest: vcs0 [608.448285] Dynamic subtest vcs0: SUCCESS (1.912s) [608.462735] Starting dynamic subtest: vcs1 [610.433433] Dynamic subtest vcs1: SUCCESS (1.991s) [610.446949] Starting dynamic subtest: vecs0 [612.417254] Dynamic subtest vecs0: SUCCESS (1.988s) [612.430483] Starting dynamic subtest: ccs0 [613.094709] Dynamic subtest ccs0: SUCCESS (0.678s) [613.097659] Subtest busy-idle: SUCCESS (7.967s) [613.193563] [099/156] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [613.296112] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [613.300166] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [613.405812] [100/156] (412s left) kms_joiner (invalid-modeset-force-ultra-joiner) [613.500389] Starting subtest: invalid-modeset-force-ultra-joiner [613.504343] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [613.568850] [101/156] (412s left) kms_psr (pr-primary-mmap-gtt) [613.669439] Starting subtest: pr-primary-mmap-gtt [613.673858] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [613.746075] [102/156] (412s left) kms_pm_rpm (fences-dpms) [615.577704] Starting subtest: fences-dpms [615.583065] Subtest fences-dpms: SKIP (0.000s) [616.054109] [103/156] (410s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [616.146246] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [616.148604] Starting dynamic subtest: pipe-A-eDP-1 [616.172002] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [616.185371] Starting dynamic subtest: pipe-B-eDP-1 [616.206988] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [616.216867] Starting dynamic subtest: pipe-C-eDP-1 [616.238773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [616.249295] Starting dynamic subtest: pipe-D-eDP-1 [616.270639] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [616.275055] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s) [618.426195] [104/156] (407s left) kms_force_connector_basic (prune-stale-modes) [618.499589] Starting subtest: prune-stale-modes [618.947681] Subtest prune-stale-modes: SUCCESS (0.449s) [619.084915] [105/156] (407s left) kms_mmap_write_crc (main) [619.191883] Starting subtest: main [619.194330] Starting dynamic subtest: pipe-A-eDP-1 [622.755975] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.568s) [622.758490] Subtest main: SUCCESS (3.569s) [623.626912] [106/156] (402s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [623.724853] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [623.729067] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [623.800289] [107/156] (402s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [623.902939] Starting subtest: drrs-dirtyfb-ioctl [623.915723] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [624.026049] [108/156] (402s left) kms_plane_multiple (tiling-4) [624.120085] Starting subtest: tiling-4 [624.121949] Starting dynamic subtest: pipe-A-eDP-1 [627.971271] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.851s) [627.983447] Starting dynamic subtest: pipe-B-eDP-1 [632.558988] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.581s) [632.570136] Starting dynamic subtest: pipe-C-eDP-1 [637.170991] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.606s) [637.189874] Starting dynamic subtest: pipe-D-eDP-1 [641.768594] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.594s) [641.770711] Subtest tiling-4: SUCCESS (17.639s) [642.653453] [109/156] (383s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [642.768153] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [642.770438] Starting dynamic subtest: pipe-A-eDP-1 [642.795314] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [642.807045] Starting dynamic subtest: pipe-B-eDP-1 [642.831200] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [642.841378] Starting dynamic subtest: pipe-C-eDP-1 [642.865599] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [642.875704] Starting dynamic subtest: pipe-D-eDP-1 [642.899798] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [642.903956] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s) [645.040159] [110/156] (381s left) syncobj_timeline (wait-zero-handles) [645.102529] Starting subtest: wait-zero-handles [645.104908] Subtest wait-zero-handles: SUCCESS (0.000s) [645.211580] [111/156] (381s left) gen7_exec_parse (oacontrol-tracking) [645.263160] Subtest oacontrol-tracking: SKIP (0.000s) [645.337762] [112/156] (381s left) gem_userptr_blits (coherency-sync) [645.402296] Starting subtest: coherency-sync [645.896692] Subtest coherency-sync: SKIP (0.459s) [646.036470] [113/156] (380s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt) [646.195378] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt [646.199244] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [646.285364] [114/156] (380s left) kms_busy (extended-pageflip-hang-oldfb) [646.381503] Starting subtest: extended-pageflip-hang-oldfb [646.383920] Starting dynamic subtest: pipe-A [646.820961] Dynamic subtest pipe-A: SUCCESS (0.438s) [646.832215] Starting dynamic subtest: pipe-D [647.929104] Dynamic subtest pipe-D: SUCCESS (1.106s) [647.931433] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.549s) [648.745880] [115/156] (377s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [648.845415] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [648.849336] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [648.940467] [116/156] (377s left) gem_set_tiling_vs_pwrite [649.054536] [117/156] (377s left) gem_exec_reloc (basic-gtt-wc) [649.109388] Subtest basic-gtt-wc: SKIP (0.000s) [649.197867] [118/156] (377s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [649.302754] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [649.306714] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [649.425227] [119/156] (377s left) gem_partial_pwrite_pread (write-display) [649.482725] Subtest write-display: SKIP (0.000s) [649.565499] [120/156] (377s left) kms_cursor_edge_walk (64x64-top-bottom) [649.661773] Starting subtest: 64x64-top-bottom [649.663859] Starting dynamic subtest: pipe-A-eDP-1 [653.172033] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s) [653.184564] Starting dynamic subtest: pipe-D-eDP-1 [656.353416] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.182s) [656.356002] Subtest 64x64-top-bottom: SUCCESS (6.693s) [657.264465] [121/156] (369s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [657.367099] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [657.369567] Starting dynamic subtest: pipe-A-eDP-1 [657.392546] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [657.405058] Starting dynamic subtest: pipe-B-eDP-1 [657.425788] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [657.436091] Starting dynamic subtest: pipe-C-eDP-1 [657.458333] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [657.468243] Starting dynamic subtest: pipe-D-eDP-1 [657.490200] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [657.494601] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s) [659.630867] [122/156] (367s left) gem_mmap_offset (clear) [659.695221] Starting subtest: clear [659.697929] Starting dynamic subtest: smem0 [683.431718] Dynamic subtest smem0: SUCCESS (23.739s) [683.433698] Subtest clear: SUCCESS (23.740s) [683.573647] [123/156] (343s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [683.731685] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [683.735597] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [683.802524] [124/156] (343s left) kms_psr (psr2-primary-blt) [683.903096] Starting subtest: psr2-primary-blt [683.905286] Starting dynamic subtest: eDP-1 [685.690476] Dynamic subtest eDP-1: SUCCESS (1.788s) [685.692773] Subtest psr2-primary-blt: SUCCESS (1.789s) [686.538440] [125/156] (340s left) kms_atomic_transition (plane-all-modeset-transition) [686.646080] Starting subtest: plane-all-modeset-transition [686.650398] Subtest plane-all-modeset-transition: SKIP (0.000s) [686.721706] [126/156] (340s left) kms_sequence (queue-busy) [686.820666] Starting subtest: queue-busy [686.823075] Starting dynamic subtest: pipe-A-eDP-1 [688.740699] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s) [688.753622] Starting dynamic subtest: pipe-B-eDP-1 [691.394976] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.651s) [691.406881] Starting dynamic subtest: pipe-C-eDP-1 [693.979593] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.583s) [693.992464] Starting dynamic subtest: pipe-D-eDP-1 [696.579274] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.598s) [696.581635] Subtest queue-busy: SUCCESS (9.759s) [697.430036] [127/156] (329s left) kms_plane (pixel-format-linear-modifier-source-clamping) [697.537192] Starting subtest: pixel-format-linear-modifier-source-clamping [697.563758] Starting dynamic subtest: pipe-A-plane-0 [698.152722] Dynamic subtest pipe-A-plane-0: SUCCESS (0.589s) [698.165942] Starting dynamic subtest: pipe-A-plane-3 [698.585454] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s) [699.692527] Starting dynamic subtest: pipe-B-plane-0 [700.258462] Dynamic subtest pipe-B-plane-0: SUCCESS (0.577s) [700.272896] Starting dynamic subtest: pipe-B-plane-3 [700.746910] Dynamic subtest pipe-B-plane-3: SUCCESS (0.488s) [701.060700] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.522s) [701.929435] [128/156] (325s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc) [702.032645] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc [702.037052] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [702.158195] [129/156] (325s left) kms_vblank (ts-continuation-modeset-hang) [702.258394] Starting subtest: ts-continuation-modeset-hang [702.260591] Starting dynamic subtest: pipe-A-eDP-1 [729.157577] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.897s) [729.174581] Starting dynamic subtest: pipe-D-eDP-1 [754.169718] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.010s) [754.172132] Subtest ts-continuation-modeset-hang: SUCCESS (51.912s) [755.025094] [130/156] (272s left) gem_exec_params (invalid-ring) [755.078076] Starting subtest: invalid-ring [755.080464] Subtest invalid-ring: SUCCESS (0.000s) [755.206599] [131/156] (272s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt) [755.324550] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt [755.328589] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [755.421415] [132/156] (271s left) perf_pmu (most-busy-idle-check-all) [755.459480] Starting subtest: most-busy-idle-check-all [755.461772] Starting dynamic subtest: rcs0 [757.441792] Dynamic subtest rcs0: SUCCESS (1.981s) [757.457648] Starting dynamic subtest: bcs0 [759.361469] Dynamic subtest bcs0: SUCCESS (1.917s) [759.374059] Starting dynamic subtest: vcs0 [761.410139] Dynamic subtest vcs0: SUCCESS (2.046s) [761.422624] Starting dynamic subtest: vcs1 [763.392136] Dynamic subtest vcs1: SUCCESS (1.980s) [763.404423] Starting dynamic subtest: vecs0 [765.377424] Dynamic subtest vecs0: SUCCESS (1.982s) [765.391297] Starting dynamic subtest: ccs0 [767.424475] Dynamic subtest ccs0: SUCCESS (2.045s) [767.427170] Subtest most-busy-idle-check-all: SUCCESS (11.968s) [767.547906] [133/156] (259s left) gem_ctx_persistence (idempotent) [767.600503] Starting subtest: idempotent [767.602905] Subtest idempotent: SUCCESS (0.000s) [767.719042] [134/156] (259s left) kms_psr (fbc-psr-dpms) [767.824732] Starting subtest: fbc-psr-dpms [767.827149] Starting dynamic subtest: eDP-1 [767.831229] Dynamic subtest eDP-1: SKIP (0.000s) [767.835235] Subtest fbc-psr-dpms: SKIP (0.001s) [767.902289] [135/156] (259s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [768.007136] Starting subtest: async-flip-with-page-flip-events-tiled [768.379493] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [771.218622] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.787s) [771.232353] Starting dynamic subtest: pipe-A-eDP-1-4 [773.391593] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s) [773.407867] Starting dynamic subtest: pipe-A-eDP-1-4 [775.349116] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [775.361887] Starting dynamic subtest: pipe-A-eDP-1-x [777.579718] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [777.893605] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [780.714002] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.777s) [780.727570] Starting dynamic subtest: pipe-B-eDP-1-4 [782.897382] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.183s) [782.917436] Starting dynamic subtest: pipe-B-eDP-1-4 [784.854744] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [784.866247] Starting dynamic subtest: pipe-B-eDP-1-x [787.085307] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s) [787.402570] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [790.213718] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.771s) [790.227799] Starting dynamic subtest: pipe-C-eDP-1-4 [792.387453] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [792.401442] Starting dynamic subtest: pipe-C-eDP-1-4 [794.345641] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [794.360340] Starting dynamic subtest: pipe-C-eDP-1-x [796.575576] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s) [796.890296] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [799.650291] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.773s) [799.661949] Starting dynamic subtest: pipe-D-eDP-1-4 [801.884555] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s) [801.898697] Starting dynamic subtest: pipe-D-eDP-1-4 [803.833087] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [803.844893] Starting dynamic subtest: pipe-D-eDP-1-x [806.011845] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s) [806.014274] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.013s) [807.207938] [136/156] (220s left) api_intel_bb (object-reloc-keep-cache) [807.268972] Starting subtest: object-reloc-keep-cache [807.273227] Subtest object-reloc-keep-cache: SKIP (0.002s) [807.402904] [137/156] (220s left) prime_self_import (export-vs-gem_close-race) [807.439656] Starting subtest: export-vs-gem_close-race [812.527412] Subtest export-vs-gem_close-race: SUCCESS (5.073s) [812.593278] [138/156] (215s left) kms_big_fb (x-tiled-16bpp-rotate-90) [812.704834] Starting subtest: x-tiled-16bpp-rotate-90 [812.724847] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s) [812.862905] [139/156] (214s left) gem_ctx_freq (sysfs) [812.922780] Starting subtest: sysfs [812.925566] Starting dynamic subtest: gt0 [818.436050] Dynamic subtest gt0: SUCCESS (5.514s) [818.449509] Starting dynamic subtest: gt1 [860.416001] Dynamic subtest gt1: SUCCESS (41.968s) [860.418866] Subtest sysfs: SUCCESS (47.485s) [860.538508] [140/156] (167s left) gem_eio (in-flight-contexts-immediate) [860.743000] Starting subtest: in-flight-contexts-immediate [874.455268] Subtest in-flight-contexts-immediate: SUCCESS (13.711s) [874.633822] [141/156] (153s left) gem_softpin (allocator-nopin-reserve) [874.682853] Starting subtest: allocator-nopin-reserve [874.761980] Subtest allocator-nopin-reserve: SUCCESS (0.078s) [874.908959] [142/156] (152s left) kms_cursor_crc (cursor-random-max-size) [875.228226] Starting subtest: cursor-random-max-size [875.234753] Subtest cursor-random-max-size: SKIP (0.000s) [875.364103] [143/156] (152s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary) [875.462973] Starting subtest: psrhdr-indfb-scaledprimary [875.466388] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s) [875.560589] [144/156] (152s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [875.688193] Starting subtest: cursorB-vs-flipB-varying-size [875.692037] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [875.833863] [145/156] (152s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [875.926664] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu [875.930394] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [876.035860] [146/156] (151s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [876.139488] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [877.242129] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.101s) [877.379865] [147/156] (150s left) prime_vgem (sync) [877.456137] Starting subtest: sync [877.458199] Starting dynamic subtest: rcs0 [877.514163] Dynamic subtest rcs0: SUCCESS (0.058s) [877.526085] Starting dynamic subtest: bcs0 [877.568300] Dynamic subtest bcs0: SUCCESS (0.053s) [877.579852] Starting dynamic subtest: vcs0 [877.617834] Dynamic subtest vcs0: SUCCESS (0.049s) [877.629171] Starting dynamic subtest: vcs1 [877.665877] Dynamic subtest vcs1: SUCCESS (0.047s) [877.677084] Starting dynamic subtest: vecs0 [877.711417] Dynamic subtest vecs0: SUCCESS (0.044s) [877.722399] Starting dynamic subtest: ccs0 [877.757413] Dynamic subtest ccs0: SUCCESS (0.045s) [877.759167] Subtest sync: SUCCESS (0.302s) [877.894254] [148/156] (150s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [877.953294] Starting subtest: invalid-multi-wait-all-unsubmitted [877.955099] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [878.047816] [149/156] (150s left) tools_test (sysfs_l3_parity) [878.092794] Starting subtest: sysfs_l3_parity [878.163398] Subtest sysfs_l3_parity: SKIP (0.078s) [878.219757] [150/156] (149s left) gem_exec_schedule (in-order) [878.294580] Starting subtest: in-order [878.296481] Starting dynamic subtest: rcs0 [878.391759] Dynamic subtest rcs0: SUCCESS (0.099s) [878.405298] Starting dynamic subtest: vcs0 [878.478644] Dynamic subtest vcs0: SUCCESS (0.086s) [878.492907] Starting dynamic subtest: vcs1 [878.559685] Dynamic subtest vcs1: SUCCESS (0.080s) [878.572984] Starting dynamic subtest: vecs0 [878.648870] Dynamic subtest vecs0: SUCCESS (0.088s) [878.663633] Starting dynamic subtest: ccs0 [878.745589] Dynamic subtest ccs0: SUCCESS (0.095s) [878.748062] Subtest in-order: SUCCESS (0.452s) [880.487410] [151/156] (147s left) kms_big_fb (y-tiled-32bpp-rotate-90) [880.596457] Starting subtest: y-tiled-32bpp-rotate-90 [880.601044] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [880.718482] [152/156] (147s left) gem_flink_basic (bad-flink) [880.777488] Starting subtest: bad-flink [880.779455] Subtest bad-flink: SUCCESS (0.000s) [880.896667] [153/156] (147s left) gem_create (create-ext-cpu-access-big) [881.066370] Starting subtest: create-ext-cpu-access-big [881.071356] Subtest create-ext-cpu-access-big: SKIP (0.001s) [881.151063] [154/156] (147s left) gem_exec_balancer (nohangcheck) [881.406656] Starting subtest: nohangcheck [882.328414] Subtest nohangcheck: SUCCESS (0.922s) [882.455934] [155/156] (145s left) gem_ctx_bad_destroy (invalid-default-ctx) [882.522460] Starting subtest: invalid-default-ctx [882.524826] Subtest invalid-default-ctx: SUCCESS (0.000s) [882.601212] [156/156] (145s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [882.700097] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [887.203580] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.509s) [888.414853] Closing watchdogs results: parsing output: 0/ for test: prime_vgem results: parsing output: 1/ for test: core_setmaster results: parsing output: 2/ for test: kms_plane_scaling results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_pipe_crc_basic results: parsing output: 5/ for test: gem_exec_schedule results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: gem_render_copy results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_exec_balancer results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_lmem_swapping results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: prime_mmap results: parsing output: 17/ for test: kms_cursor_legacy results: parsing output: 18/ for test: gem_huc_copy results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: prime_vgem results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_wait results: parsing output: 23/ for test: kms_addfb_basic results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_atomic_transition results: parsing output: 31/ for test: gem_exec_reloc results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_chamelium_frames results: parsing output: 34/ for test: fbdev results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: i915_pm_rpm results: parsing output: 37/ for test: kms_psr results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_psr2_sf results: parsing output: 40/ for test: i915_selftest results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_exec_schedule results: parsing output: 44/ for test: gem_softpin results: parsing output: 45/ for test: drm_read results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_getfb results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: i915_hangman results: parsing output: 50/ for test: gem_ppgtt results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: syncobj_wait results: parsing output: 53/ for test: gem_ctx_shared results: parsing output: 54/ for test: kms_draw_crc results: parsing output: 55/ for test: i915_drm_fdinfo results: parsing output: 56/ for test: kms_ccs results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: gem_exec_whisper results: parsing output: 59/ for test: syncobj_timeline results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_ccs results: parsing output: 62/ for test: kms_pm_rpm results: parsing output: 63/ for test: kms_flip_scaled_crc results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: syncobj_eventfd results: parsing output: 66/ for test: kms_pm_backlight results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_flip results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_content_protection results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_rotation_crc results: parsing output: 79/ for test: gem_exec_flush results: parsing output: 80/ for test: gem_mmap_gtt results: parsing output: 81/ for test: kms_color results: parsing output: 82/ for test: gem_exec_params results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: gem_render_copy results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: prime_vgem results: parsing output: 91/ for test: kms_chamelium_hpd results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_exec_fence results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: perf results: parsing output: 97/ for test: perf_pmu results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_joiner results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: kms_pm_rpm results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: kms_force_connector_basic results: parsing output: 104/ for test: kms_mmap_write_crc results: parsing output: 105/ for test: kms_psr2_sf results: parsing output: 106/ for test: kms_dirtyfb results: parsing output: 107/ for test: kms_plane_multiple results: parsing output: 108/ for test: kms_ccs results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: gen7_exec_parse results: parsing output: 111/ for test: gem_userptr_blits results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_busy results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_set_tiling_vs_pwrite results: parsing output: 116/ for test: gem_exec_reloc results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_partial_pwrite_pread results: parsing output: 119/ for test: kms_cursor_edge_walk results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: gem_mmap_offset results: parsing output: 122/ for test: kms_flip_scaled_crc results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_atomic_transition results: parsing output: 125/ for test: kms_sequence results: parsing output: 126/ for test: kms_plane results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_vblank results: parsing output: 129/ for test: gem_exec_params results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: perf_pmu results: parsing output: 132/ for test: gem_ctx_persistence results: parsing output: 133/ for test: kms_psr results: parsing output: 134/ for test: kms_async_flips results: parsing output: 135/ for test: api_intel_bb results: parsing output: 136/ for test: prime_self_import results: parsing output: 137/ for test: kms_big_fb results: parsing output: 138/ for test: gem_ctx_freq results: parsing output: 139/ for test: gem_eio results: parsing output: 140/ for test: gem_softpin results: parsing output: 141/ for test: kms_cursor_crc results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_cursor_legacy results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_big_fb results: parsing output: 146/ for test: prime_vgem results: parsing output: 147/ for test: syncobj_wait results: parsing output: 148/ for test: tools_test results: parsing output: 149/ for test: gem_exec_schedule results: parsing output: 150/ for test: kms_big_fb results: parsing output: 151/ for test: gem_flink_basic results: parsing output: 152/ for test: gem_create results: parsing output: 153/ for test: gem_exec_balancer results: parsing output: 154/ for test: gem_ctx_bad_destroy results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.