[57.941989] Initializing watchdogs
[57.942081]   /dev/watchdog0
[57.957022] [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.961663] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.963971] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.967177] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[58.109358] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[65.507100] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.423s)
[65.678302] [002/133] (952s left) i915_module_load (reload-no-display)
[65.714848] Starting subtest: reload-no-display
[71.588814] Subtest reload-no-display: SUCCESS (5.880s)
[71.616271] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[71.619215] [003/133] (946s left) gem_exec_balancer (indices)
[73.183282] Starting subtest: indices
[75.895109] Subtest indices: SUCCESS (2.711s)
[76.167069] [FACT gem_exec_balancer (indices)] new: kernel.kmod_is_loaded.i915: true
[76.170882] [004/133] (942s left) kms_busy (basic-hang)
[76.281764] Starting subtest: basic-hang
[76.284149] Starting dynamic subtest: flip-pipe-A
[76.944079] Dynamic subtest flip-pipe-A: SUCCESS (0.662s)
[76.952540] Starting dynamic subtest: modeset-pipe-A
[80.355197] Dynamic subtest modeset-pipe-A: SUCCESS (3.411s)
[80.363424] Starting dynamic subtest: flip-pipe-D
[81.553558] Dynamic subtest flip-pipe-D: SUCCESS (1.198s)
[81.567769] Starting dynamic subtest: modeset-pipe-D
[84.964398] Dynamic subtest modeset-pipe-D: SUCCESS (3.408s)
[84.966945] Subtest basic-hang: SUCCESS (8.684s)
[85.768515] [005/133] (932s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[85.874835] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[90.328252] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.458s)
[91.487390] [006/133] (927s left) gem_exec_schedule (implicit-read-write)
[91.567841] Starting subtest: implicit-read-write
[91.570221] Starting dynamic subtest: rcs0
[91.676396] Dynamic subtest rcs0: SUCCESS (0.118s)
[91.687450] Starting dynamic subtest: vcs0
[91.755221] Dynamic subtest vcs0: SUCCESS (0.079s)
[91.765629] Starting dynamic subtest: vcs1
[91.838434] Dynamic subtest vcs1: SUCCESS (0.083s)
[91.848757] Starting dynamic subtest: vecs0
[91.912952] Dynamic subtest vecs0: SUCCESS (0.074s)
[91.923499] Starting dynamic subtest: ccs0
[91.991518] Dynamic subtest ccs0: SUCCESS (0.078s)
[91.993949] Subtest implicit-read-write: SUCCESS (0.434s)
[92.966886] [007/133] (925s left) kms_atomic (plane-overlay-legacy)
[93.066333] Starting subtest: plane-overlay-legacy
[93.068566] Starting dynamic subtest: pipe-A-eDP-1
[93.496740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s)
[93.499171] Subtest plane-overlay-legacy: SUCCESS (0.432s)
[94.296200] [008/133] (924s left) kms_lease (cursor-implicit-plane)
[94.401832] Starting subtest: cursor-implicit-plane
[94.404188] Starting dynamic subtest: pipe-A-eDP-1
[94.863871] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[94.874198] Starting dynamic subtest: pipe-B-eDP-1
[96.031283] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s)
[96.042169] Starting dynamic subtest: pipe-C-eDP-1
[97.127446] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.096s)
[97.137691] Starting dynamic subtest: pipe-D-eDP-1
[98.249125] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[98.251678] Subtest cursor-implicit-plane: SUCCESS (3.849s)
[99.116910] [009/133] (919s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[99.214487] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[99.218860] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[99.307579] [010/133] (919s left) gem_caching (writes)
[99.376280] Subtest writes: SKIP (0.000s)
[99.447851] [011/133] (919s left) device_reset (unbind-cold-reset-rebind)
[99.495151] Starting subtest: unbind-cold-reset-rebind
[99.499875] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[99.571070] [012/133] (919s left) kms_cdclk (mode-transition-all-outputs)
[99.673090] Starting subtest: mode-transition-all-outputs
[99.965053] Subtest mode-transition-all-outputs: SKIP (0.290s)
[100.757319] [013/133] (918s left) gem_mmap_wc (pf-nonblock)
[100.811060] Subtest pf-nonblock: SKIP (0.000s)
[100.867189] [014/133] (918s left) perf (i915-ref-count)
[100.934972] Starting subtest: i915-ref-count
[101.009066] Subtest i915-ref-count: SUCCESS (0.072s)
[101.066060] [015/133] (917s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[101.158787] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[101.160680] Starting dynamic subtest: A-eDP1
[104.805424] Dynamic subtest A-eDP1: SUCCESS (3.647s)
[104.815456] Starting dynamic subtest: B-eDP1
[108.006627] Dynamic subtest B-eDP1: SUCCESS (3.199s)
[108.016938] Starting dynamic subtest: C-eDP1
[111.205852] Dynamic subtest C-eDP1: SUCCESS (3.200s)
[111.214079] Starting dynamic subtest: D-eDP1
[114.325371] Dynamic subtest D-eDP1: SUCCESS (3.119s)
[114.327688] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.172s)
[115.140613] [016/133] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[115.234486] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[115.238589] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[115.332511] [017/133] (903s left) gem_create (create-ext-cpu-access-big)
[115.506304] Starting subtest: create-ext-cpu-access-big
[115.511013] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[115.589192] [018/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[115.726544] Starting subtest: cursorB-vs-flipA-varying-size
[115.732816] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[115.888008] [019/133] (903s left) kms_psr (fbc-psr-cursor-plane-move)
[115.970996] Starting subtest: fbc-psr-cursor-plane-move
[115.972926] Starting dynamic subtest: eDP-1
[115.977779] Dynamic subtest eDP-1: SKIP (0.000s)
[115.982642] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[116.041727] [020/133] (903s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[116.111380] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[116.115691] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[116.304195] [021/133] (903s left) kms_scaling_modes (scaling-mode-full)
[116.388273] Starting subtest: scaling-mode-full
[116.390774] Starting dynamic subtest: pipe-A-eDP-1
[116.479430] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[116.488930] Starting dynamic subtest: pipe-B-eDP-1
[117.649309] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.169s)
[117.658636] Starting dynamic subtest: pipe-C-eDP-1
[118.758606] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[118.766782] Starting dynamic subtest: pipe-D-eDP-1
[119.906048] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[119.908358] Subtest scaling-mode-full: SUCCESS (3.520s)
[121.061791] [022/133] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[121.161415] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[128.696053] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.538s)
[128.827751] [023/133] (890s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[128.923684] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[135.458418] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.539s)
[135.558734] [024/133] (883s left) gem_exec_reloc (basic-wc-gtt-active)
[135.619753] Subtest basic-wc-gtt-active: SKIP (0.000s)
[135.683046] [025/133] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[135.777471] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[135.781634] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[135.873102] [026/133] (883s left) kms_plane_scaling (invalid-num-scalers)
[135.962846] Starting subtest: invalid-num-scalers
[135.965056] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[135.983467] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[135.992092] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[136.018522] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[136.026586] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[136.051954] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[136.059906] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[136.085403] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[136.087643] Subtest invalid-num-scalers: SUCCESS (0.123s)
[136.187239] [027/133] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[136.294070] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[136.298153] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[136.394780] [028/133] (883s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[136.490640] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[142.863313] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.376s)
[144.015727] [029/133] (875s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[144.136746] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[144.140998] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[144.235979] [030/133] (875s left) kms_cursor_crc (cursor-offscreen-64x21)
[144.432690] Starting subtest: cursor-offscreen-64x21
[144.483926] Subtest cursor-offscreen-64x21: SKIP (0.046s)
[144.729870] [031/133] (874s left) i915_pm_rps (min-max-config-idle)
[144.792432] Starting subtest: min-max-config-idle
[144.797024] Subtest min-max-config-idle: SKIP (0.001s)
[144.896714] [032/133] (874s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[144.955098] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[145.059314] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[145.132803] [033/133] (874s left) gem_exec_store (pages)
[145.196495] Starting subtest: pages
[145.198964] Starting dynamic subtest: rcs0
[145.294572] Dynamic subtest rcs0: SUCCESS (0.097s)
[145.304294] Starting dynamic subtest: bcs0
[145.363491] Dynamic subtest bcs0: SUCCESS (0.068s)
[145.371355] Starting dynamic subtest: vcs0
[145.434547] Dynamic subtest vcs0: SUCCESS (0.070s)
[145.443809] Starting dynamic subtest: vcs1
[145.506283] Dynamic subtest vcs1: SUCCESS (0.071s)
[145.516119] Starting dynamic subtest: vecs0
[145.573566] Dynamic subtest vecs0: SUCCESS (0.066s)
[145.583848] Starting dynamic subtest: ccs0
[145.648802] Dynamic subtest ccs0: SUCCESS (0.075s)
[145.651096] Subtest pages: SUCCESS (0.453s)
[145.832960] [034/133] (873s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[146.206166] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[147.010450] [035/133] (872s left) kms_cursor_edge_walk (64x64-left-edge)
[147.101204] Starting subtest: 64x64-left-edge
[147.103478] Starting dynamic subtest: pipe-A-eDP-1
[150.593066] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[150.602263] Starting dynamic subtest: pipe-D-eDP-1
[153.723605] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[153.726044] Subtest 64x64-left-edge: SUCCESS (6.624s)
[154.518835] [036/133] (865s left) gem_ctx_shared (exec-shared-gtt)
[154.583667] Starting subtest: exec-shared-gtt
[154.585988] Starting dynamic subtest: rcs0
[154.594320] Dynamic subtest rcs0: SUCCESS (0.010s)
[154.603635] Starting dynamic subtest: bcs0
[154.605857] Dynamic subtest bcs0: SUCCESS (0.006s)
[154.614086] Starting dynamic subtest: vcs0
[154.616413] Dynamic subtest vcs0: SUCCESS (0.007s)
[154.624367] Starting dynamic subtest: vcs1
[154.626195] Dynamic subtest vcs1: SUCCESS (0.006s)
[154.634435] Starting dynamic subtest: vecs0
[154.636647] Dynamic subtest vecs0: SUCCESS (0.008s)
[154.644479] Starting dynamic subtest: ccs0
[154.646656] Dynamic subtest ccs0: SUCCESS (0.005s)
[154.648857] Subtest exec-shared-gtt: SUCCESS (0.046s)
[154.815306] [037/133] (865s left) kms_flip (flip-vs-absolute-wf_vblank)
[154.912125] Starting subtest: flip-vs-absolute-wf_vblank
[154.914014] Starting dynamic subtest: A-eDP1
[163.870038] Dynamic subtest A-eDP1: SUCCESS (8.959s)
[163.880769] Starting dynamic subtest: B-eDP1
[172.802566] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[172.813497] Starting dynamic subtest: C-eDP1
[181.719568] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[181.727732] Starting dynamic subtest: D-eDP1
[190.661505] Dynamic subtest D-eDP1: SUCCESS (8.939s)
[190.663825] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.754s)
[191.879989] [038/133] (828s left) kms_async_flips (async-flip-hang)
[191.988240] Starting subtest: async-flip-hang
[192.361732] Starting dynamic subtest: pipe-A-eDP-1
[207.349080] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.986s)
[207.723562] Starting dynamic subtest: pipe-B-eDP-1
[223.348447] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.629s)
[223.734718] Starting dynamic subtest: pipe-C-eDP-1
[239.343171] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.617s)
[239.719176] Starting dynamic subtest: pipe-D-eDP-1
[255.344179] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.630s)
[255.347206] Subtest async-flip-hang: SUCCESS (63.359s)
[256.528336] [039/133] (763s left) syncobj_timeline (wait-all-complex)
[256.582780] Starting subtest: wait-all-complex
[256.796847] Subtest wait-all-complex: SUCCESS (0.214s)
[256.885148] [040/133] (763s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[257.282338] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[258.127822] [041/133] (761s left) gem_mmap_gtt (basic-small-copy-xy)
[258.189610] Subtest basic-small-copy-XY: SKIP (0.000s)
[258.241185] [042/133] (761s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[258.367582] Starting subtest: protected-encrypted-src-copy-not-readible
[258.478835] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[258.619218] [043/133] (761s left) gem_mmap_wc (fault-concurrent)
[258.677202] Subtest fault-concurrent: SKIP (0.000s)
[258.727337] [044/133] (761s left) kms_content_protection (suspend-resume)
[258.862421] Starting subtest: suspend-resume
[258.867068] Subtest suspend-resume: SKIP (0.000s)
[259.003602] [045/133] (761s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[259.105367] Starting subtest: psr-rgb565-draw-render
[266.050193] Subtest psr-rgb565-draw-render: SUCCESS (6.946s)
[266.181476] [046/133] (754s left) gen9_exec_parse (bb-oversize)
[266.252677] Subtest bb-oversize: SKIP (0.000s)
[266.326823] [047/133] (754s left) kms_rotation_crc (sprite-rotation-90)
[266.412361] Starting subtest: sprite-rotation-90
[266.416790] Subtest sprite-rotation-90: SKIP (0.001s)
[266.497363] [048/133] (753s left) syncobj_eventfd (invalid-illegal-eventfd)
[266.543085] Starting subtest: invalid-illegal-eventfd
[266.545351] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[266.631200] [049/133] (753s left) kms_pipe_crc_basic (bad-source)
[266.719164] Starting subtest: bad-source
[266.721429] Subtest bad-source: SUCCESS (0.000s)
[266.790484] [050/133] (753s left) template (a)
[266.844722] Starting subtest: A
[266.846747] Subtest A: SUCCESS (0.000s)
[266.953785] [051/133] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[267.053872] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[267.057213] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[267.148811] [052/133] (753s left) gem_tiled_pread_pwrite
[267.270311] [053/133] (753s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[267.364927] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[267.367074] Starting dynamic subtest: pipe-A
[267.383540] Dynamic subtest pipe-A: SKIP (0.018s)
[267.392113] Starting dynamic subtest: pipe-B
[267.417771] Dynamic subtest pipe-B: SKIP (0.032s)
[267.426523] Starting dynamic subtest: pipe-C
[267.450717] Dynamic subtest pipe-C: SKIP (0.032s)
[267.458546] Starting dynamic subtest: pipe-D
[267.482348] Dynamic subtest pipe-D: SKIP (0.032s)
[267.485505] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.116s)
[267.559442] [054/133] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[267.659060] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[267.662576] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[267.751981] [055/133] (752s left) kms_pm_rpm (cursor)
[269.274835] Starting subtest: cursor
[269.279803] Subtest cursor: SKIP (0.000s)
[270.029492] [056/133] (750s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[270.126170] Starting subtest: psr2-overlay-plane-update-continuous-sf
[270.128479] Starting dynamic subtest: pipe-A-eDP-1
[271.241690] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.118s)
[271.250867] Starting dynamic subtest: pipe-B-eDP-1
[272.957403] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.712s)
[272.959341] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.833s)
[273.783653] [057/133] (746s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[273.840536] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[273.842910] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[273.935744] [058/133] (746s left) api_intel_allocator (reopen-fork)
[273.983526] Starting subtest: reopen-fork
[277.239488] Subtest reopen-fork: SUCCESS (3.257s)
[277.315450] [059/133] (743s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[277.415542] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[277.443934] Starting dynamic subtest: pipe-A-plane-0
[277.732443] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[277.743613] Starting dynamic subtest: pipe-A-plane-3
[277.968129] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[277.978190] Starting dynamic subtest: pipe-A-plane-5
[277.982480] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[279.062058] Starting dynamic subtest: pipe-B-plane-0
[279.355603] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[279.363931] Starting dynamic subtest: pipe-B-plane-3
[279.588555] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[279.599239] Starting dynamic subtest: pipe-B-plane-5
[279.603723] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[279.911653] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.495s)
[280.728424] [060/133] (740s left) kms_big_fb (linear-16bpp-rotate-0)
[280.829767] Starting subtest: linear-16bpp-rotate-0
[282.253095] Subtest linear-16bpp-rotate-0: SUCCESS (1.423s)
[282.360932] [061/133] (738s left) gem_exec_fence (syncobj-timeline-signal)
[282.940526] Starting subtest: syncobj-timeline-signal
[282.946963] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[283.997804] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[284.001485] [062/133] (736s left) kms_selftest (drm_format_helper)
[284.040810] Starting subtest: drm_format_helper
[284.045730] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[284.153079] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.107s)
[284.162345] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[284.255932] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.104s)
[284.266128] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[284.373070] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.117s)
[284.383098] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[284.479226] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.103s)
[284.489322] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[284.574045] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.095s)
[284.584210] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[284.671574] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.093s)
[284.680113] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[284.771077] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.099s)
[284.780092] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[284.862565] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.093s)
[284.871598] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[284.958886] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.096s)
[284.968893] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[285.057878] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.096s)
[285.066066] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[285.155031] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.097s)
[285.164420] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[285.250897] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.095s)
[285.259212] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[285.350082] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.097s)
[285.358917] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[285.445506] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.097s)
[285.454887] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[285.546282] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.100s)
[285.555148] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[285.681370] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.134s)
[285.689742] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[285.791704] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.109s)
[285.794016] Subtest drm_format_helper: SUCCESS (1.754s)
[285.945919] [063/133] (735s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[286.050500] Starting subtest: fbc-rgb101010-draw-render
[290.661296] Subtest fbc-rgb101010-draw-render: SUCCESS (4.613s)
[291.854669] [064/133] (729s left) gem_lmem_swapping (massive-random)
[291.904477] Subtest massive-random: SKIP (0.000s)
[291.952477] [065/133] (729s left) gem_exec_schedule (preempt-user)
[292.023483] Starting subtest: preempt-user
[292.025787] Starting dynamic subtest: rcs0
[292.044097] Dynamic subtest rcs0: SUCCESS (0.027s)
[292.056636] Starting dynamic subtest: bcs0
[292.066282] Dynamic subtest bcs0: SUCCESS (0.022s)
[292.074814] Starting dynamic subtest: vcs0
[292.088692] Dynamic subtest vcs0: SUCCESS (0.022s)
[292.097305] Starting dynamic subtest: vcs1
[292.108907] Dynamic subtest vcs1: SUCCESS (0.019s)
[292.117940] Starting dynamic subtest: vecs0
[292.129742] Dynamic subtest vecs0: SUCCESS (0.020s)
[292.138222] Starting dynamic subtest: ccs0
[292.152199] Dynamic subtest ccs0: SUCCESS (0.021s)
[292.154511] Subtest preempt-user: SUCCESS (0.136s)
[293.985913] [066/133] (727s left) gem_exec_fence (keep-in-fence)
[294.151832] Starting subtest: keep-in-fence
[294.154414] Starting dynamic subtest: rcs0
[294.216881] Dynamic subtest rcs0: SUCCESS (0.065s)
[294.227919] Starting dynamic subtest: bcs0
[294.270883] Dynamic subtest bcs0: SUCCESS (0.052s)
[294.284045] Starting dynamic subtest: vcs0
[295.895261] Dynamic subtest vcs0: SUCCESS (1.621s)
[295.907157] Starting dynamic subtest: vcs1
[297.878895] Dynamic subtest vcs1: SUCCESS (1.981s)
[297.890169] Starting dynamic subtest: vecs0
[299.926736] Dynamic subtest vecs0: SUCCESS (2.045s)
[299.938720] Starting dynamic subtest: ccs0
[300.164595] Dynamic subtest ccs0: SUCCESS (0.236s)
[300.167186] Subtest keep-in-fence: SUCCESS (6.014s)
[302.005053] [067/133] (719s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[302.066484] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[302.131479] [068/133] (719s left) kms_psr (psr2-primary-page-flip)
[302.234060] Starting subtest: psr2-primary-page-flip
[302.236450] Starting dynamic subtest: eDP-1
[303.919454] Dynamic subtest eDP-1: SUCCESS (1.685s)
[303.921811] Subtest psr2-primary-page-flip: SUCCESS (1.686s)
[304.807938] [069/133] (716s left) gem_eio (in-flight-internal-10ms)
[305.021590] Starting subtest: in-flight-internal-10ms
[306.979704] Subtest in-flight-internal-10ms: SUCCESS (1.957s)
[307.101436] [070/133] (714s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[307.226467] Starting subtest: cursor-vs-flip-atomic-transitions
[337.626881] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.398s)
[338.426466] [071/133] (682s left) gem_exec_reloc (basic-gtt-wc-active)
[338.498259] Subtest basic-gtt-wc-active: SKIP (0.000s)
[338.576619] [072/133] (682s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[338.676690] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[338.678998] Starting dynamic subtest: pipe-A-eDP-1
[338.738018] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[338.748611] Starting dynamic subtest: pipe-B-eDP-1
[338.806258] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[338.817091] Starting dynamic subtest: pipe-C-eDP-1
[338.874599] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[338.885214] Starting dynamic subtest: pipe-D-eDP-1
[338.943812] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[338.948258] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[340.987775] [073/133] (680s left) kms_plane_cursor (viewport)
[341.083206] Starting subtest: viewport
[341.087770] Starting dynamic subtest: pipe-A-eDP-1-size-64
[343.676510] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.594s)
[343.736653] Starting dynamic subtest: pipe-A-eDP-1-size-128
[346.277046] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[346.337755] Starting dynamic subtest: pipe-A-eDP-1-size-256
[348.889676] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.560s)
[349.240942] Starting dynamic subtest: pipe-B-eDP-1-size-64
[352.569427] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.337s)
[352.629253] Starting dynamic subtest: pipe-B-eDP-1-size-128
[355.180560] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s)
[355.241897] Starting dynamic subtest: pipe-B-eDP-1-size-256
[357.761879] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.529s)
[358.119667] Starting dynamic subtest: pipe-C-eDP-1-size-64
[360.990146] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.881s)
[361.027439] Starting dynamic subtest: pipe-C-eDP-1-size-128
[363.201550] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.181s)
[363.240191] Starting dynamic subtest: pipe-C-eDP-1-size-256
[365.435428] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[365.769857] Starting dynamic subtest: pipe-D-eDP-1-size-64
[368.659044] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.899s)
[368.696892] Starting dynamic subtest: pipe-D-eDP-1-size-128
[370.926227] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.236s)
[370.962976] Starting dynamic subtest: pipe-D-eDP-1-size-256
[373.193305] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.236s)
[373.510554] Subtest viewport: SUCCESS (32.427s)
[374.316934] [074/133] (647s left) gem_exec_suspend (basic-s4-devices)
[374.393657] Starting subtest: basic-S4-devices
[374.396061] Starting dynamic subtest: smem
[385.879738] Dynamic subtest smem: SUCCESS (11.483s)
[385.882714] Subtest basic-S4-devices: SUCCESS (11.486s)
[392.081843] [075/133] (635s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[392.215582] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[392.995524] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.781s)
[393.171086] [076/133] (634s left) sysfs_heartbeat_interval (invalid)
[393.233312] Starting subtest: invalid
[393.235702] Starting dynamic subtest: vecs0
[393.238028] Dynamic subtest vecs0: SUCCESS (0.000s)
[393.249808] Starting dynamic subtest: ccs0
[393.252030] Dynamic subtest ccs0: SUCCESS (0.000s)
[393.273124] Starting dynamic subtest: vcs0
[393.275218] Dynamic subtest vcs0: SUCCESS (0.000s)
[393.295287] Starting dynamic subtest: bcs0
[393.297746] Dynamic subtest bcs0: SUCCESS (0.000s)
[393.319039] Starting dynamic subtest: rcs0
[393.321385] Dynamic subtest rcs0: SUCCESS (0.000s)
[393.341213] Starting dynamic subtest: vcs1
[393.343308] Dynamic subtest vcs1: SUCCESS (0.000s)
[393.345310] Subtest invalid: SUCCESS (0.006s)
[393.429705] [077/133] (634s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[393.677148] Starting subtest: cursor-rapid-movement-256x256
[393.679464] Starting dynamic subtest: pipe-A-eDP-1
[394.220792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[394.250835] Starting dynamic subtest: pipe-D-eDP-1
[395.438949] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s)
[395.441548] Subtest cursor-rapid-movement-256x256: SUCCESS (1.764s)
[396.266272] [078/133] (631s left) sriov_basic (enable-vfs-autoprobe-on)
[396.336488] Starting subtest: enable-vfs-autoprobe-on
[396.338834] Starting dynamic subtest: numvfs-1
[396.418897] Dynamic subtest numvfs-1: FAIL (0.031s)
[396.430521] Starting dynamic subtest: numvfs-2
[396.505354] Dynamic subtest numvfs-2: FAIL (0.006s)
[396.516477] Starting dynamic subtest: numvfs-3
[396.590900] Dynamic subtest numvfs-3: FAIL (0.004s)
[396.602050] Starting dynamic subtest: numvfs-4
[396.674763] Dynamic subtest numvfs-4: FAIL (0.004s)
[396.686407] Starting dynamic subtest: numvfs-5
[396.760079] Dynamic subtest numvfs-5: FAIL (0.004s)
[396.770668] Starting dynamic subtest: numvfs-6
[396.843095] Dynamic subtest numvfs-6: FAIL (0.004s)
[396.854112] Starting dynamic subtest: numvfs-7
[396.927513] Dynamic subtest numvfs-7: FAIL (0.004s)
[396.937258] Starting dynamic subtest: numvfs-random
[397.007430] Dynamic subtest numvfs-random: FAIL (0.004s)
[397.018464] Starting dynamic subtest: numvfs-all
[397.090588] Dynamic subtest numvfs-all: FAIL (0.004s)
[397.092935] Subtest enable-vfs-autoprobe-on: FAIL (0.591s)
[397.134417] [079/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[397.237069] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[397.240518] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[397.325033] [080/133] (630s left) sw_sync (alloc_fence_invalid_timeline)
[397.364012] Starting subtest: alloc_fence_invalid_timeline
[397.366054] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[397.423907] [081/133] (630s left) gem_userptr_blits (huge-split)
[397.504575] Starting subtest: huge-split
[397.516358] Subtest huge-split: SUCCESS (0.011s)
[397.644556] [082/133] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[397.737461] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[401.500587] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.766s)
[402.652575] [083/133] (625s left) gem_userptr_blits (stress-mm)
[402.716099] Starting subtest: stress-mm
[408.086186] Subtest stress-mm: SUCCESS (5.369s)
[408.203906] [084/133] (619s left) perf_pmu (render-node-busy-idle)
[408.286239] Starting subtest: render-node-busy-idle
[408.289524] Starting dynamic subtest: rcs0
[408.952742] Dynamic subtest rcs0: SUCCESS (0.667s)
[408.966117] Starting dynamic subtest: bcs0
[409.615945] Dynamic subtest bcs0: SUCCESS (0.661s)
[409.628611] Starting dynamic subtest: vcs0
[410.903413] Dynamic subtest vcs0: SUCCESS (1.283s)
[410.916816] Starting dynamic subtest: vcs1
[412.887230] Dynamic subtest vcs1: SUCCESS (1.981s)
[412.900838] Starting dynamic subtest: vecs0
[414.935756] Dynamic subtest vecs0: SUCCESS (2.045s)
[414.949205] Starting dynamic subtest: ccs0
[415.599500] Dynamic subtest ccs0: SUCCESS (0.662s)
[415.602787] Subtest render-node-busy-idle: SUCCESS (7.314s)
[415.690992] [085/133] (612s left) api_intel_bb (misplaced-blitter)
[415.755933] Starting subtest: misplaced-blitter
[415.765098] Subtest misplaced-blitter: SUCCESS (0.012s)
[415.885764] [086/133] (612s left) kms_dsc (dsc-with-output-formats)
[415.993596] Starting subtest: dsc-with-output-formats
[416.016582] Subtest dsc-with-output-formats: SKIP (0.001s)
[416.067255] [087/133] (611s left) gem_exec_reloc (basic-cpu-gtt)
[416.128782] Subtest basic-cpu-gtt: SKIP (0.000s)
[416.194884] [088/133] (611s left) i915_query (query-topology-unsupported)
[416.258215] Starting subtest: query-topology-unsupported
[416.262379] Subtest query-topology-unsupported: SKIP (0.000s)
[416.367464] [089/133] (611s left) kms_psr (pr-sprite-plane-onoff)
[416.467414] Starting subtest: pr-sprite-plane-onoff
[416.471608] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[416.550549] [090/133] (611s left) kms_vblank (query-forked-busy)
[416.662748] Starting subtest: query-forked-busy
[416.664402] Starting dynamic subtest: pipe-A-eDP-1
[418.552769] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[418.568973] Starting dynamic subtest: pipe-D-eDP-1
[421.094929] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[421.097265] Subtest query-forked-busy: SUCCESS (4.433s)
[421.898955] [091/133] (606s left) gem_render_copy (x-tiled)
[421.974184] Starting subtest: x-tiled
[421.976123] Starting dynamic subtest: smem
[422.021413] Dynamic subtest smem: SUCCESS (0.048s)
[422.023960] Subtest x-tiled: SUCCESS (0.050s)
[422.268810] [092/133] (605s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[422.399504] Starting subtest: cursorA-vs-flipA-legacy
[433.530119] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.129s)
[434.324884] [093/133] (593s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[434.385178] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[434.387367] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[434.486617] [094/133] (593s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[434.578832] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[434.583102] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[434.651202] [095/133] (593s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[434.747253] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[434.751481] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[434.840943] [096/133] (593s left) gem_mmap_wc (set-cache-level)
[434.897433] Subtest set-cache-level: SKIP (0.000s)
[434.956947] [097/133] (593s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[435.052922] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[435.055365] Starting dynamic subtest: pipe-A-eDP-1
[435.078494] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[435.091852] Starting dynamic subtest: pipe-B-eDP-1
[435.113390] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[435.123606] Starting dynamic subtest: pipe-C-eDP-1
[435.145246] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[435.155362] Starting dynamic subtest: pipe-D-eDP-1
[435.177406] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[435.181839] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[437.286180] [098/133] (591s left) kms_flip (dpms-vs-vblank-race-interruptible)
[437.381127] Starting subtest: dpms-vs-vblank-race-interruptible
[437.383498] Starting dynamic subtest: A-eDP1
[442.385353] Dynamic subtest A-eDP1: SUCCESS (5.001s)
[442.396658] Starting dynamic subtest: B-eDP1
[446.995623] Dynamic subtest B-eDP1: SUCCESS (4.607s)
[447.008822] Starting dynamic subtest: C-eDP1
[451.617781] Dynamic subtest C-eDP1: SUCCESS (4.620s)
[451.629471] Starting dynamic subtest: D-eDP1
[456.226039] Dynamic subtest D-eDP1: SUCCESS (4.606s)
[456.230319] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.848s)
[457.106696] [099/133] (571s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[457.175944] Starting subtest: invalid-bsd2-flag-on-vebox
[457.178096] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[457.271496] [100/133] (571s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[457.383526] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[457.387631] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[457.513087] [101/133] (571s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[457.637857] Starting subtest: short-flip-before-cursor-toggle
[458.551075] Subtest short-flip-before-cursor-toggle: SUCCESS (0.914s)
[459.437789] [102/133] (569s left) kms_plane_alpha_blend (constant-alpha-min)
[459.533097] Starting subtest: constant-alpha-min
[459.814521] Starting dynamic subtest: pipe-A-eDP-1
[460.557492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[460.568917] Starting dynamic subtest: pipe-D-eDP-1
[462.009256] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.450s)
[462.011578] Subtest constant-alpha-min: SUCCESS (2.475s)
[462.813480] [103/133] (565s left) syncobj_wait (wait-all-for-submit-snapshot)
[462.871963] Starting subtest: wait-all-for-submit-snapshot
[462.953623] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[463.032868] [104/133] (565s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[463.130474] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[463.143283] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[463.222102] [105/133] (565s left) kms_addfb_basic (bad-pitch-256)
[463.271199] Starting subtest: bad-pitch-256
[463.273462] Subtest bad-pitch-256: SUCCESS (0.000s)
[463.428730] [106/133] (565s left) gem_mmap_offset (blt-coherency)
[463.481154] Starting subtest: blt-coherency
[463.485444] Subtest blt-coherency: SUCCESS (0.006s)
[463.612978] [107/133] (565s left) gem_ctx_create (basic)
[463.682338] Starting subtest: basic
[463.684813] Subtest basic: SUCCESS (0.000s)
[463.880739] [108/133] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[463.991700] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[463.996037] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[464.077683] [109/133] (564s left) perf (gen12-group-concurrent-oa-buffer-read)
[464.160514] Starting subtest: gen12-group-concurrent-oa-buffer-read
[474.201052] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.039s)
[474.252313] [110/133] (554s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[474.359138] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[474.361399] Starting dynamic subtest: pipe-A-eDP-1
[474.384348] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[474.395703] Starting dynamic subtest: pipe-B-eDP-1
[474.417553] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[474.427524] Starting dynamic subtest: pipe-C-eDP-1
[474.448981] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[474.459034] Starting dynamic subtest: pipe-D-eDP-1
[474.480670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[474.484689] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[476.685494] [111/133] (552s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[476.780489] Starting subtest: fbcpsr-2p-rte
[476.784782] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[476.867070] [112/133] (552s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[476.964035] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[476.966286] Starting dynamic subtest: pipe-A-eDP-1
[477.052123] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[477.063921] Starting dynamic subtest: pipe-B-eDP-1
[478.161942] Dynamic subtest pipe-B-eDP-1: SKIP (1.107s)
[478.166751] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.199s)
[479.368080] [113/133] (549s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[479.465920] Starting subtest: x-tiled-16bpp-rotate-270
[479.486845] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[479.605030] [114/133] (549s left) gem_ctx_isolation (clean)
[479.673875] Starting subtest: clean
[479.676186] Starting dynamic subtest: rcs0
[479.730551] Dynamic subtest rcs0: SUCCESS (0.056s)
[479.743499] Starting dynamic subtest: bcs0
[479.790084] Dynamic subtest bcs0: SUCCESS (0.058s)
[479.805225] Starting dynamic subtest: vcs0
[479.877969] Dynamic subtest vcs0: SUCCESS (0.084s)
[479.890725] Starting dynamic subtest: vcs1
[481.923083] Dynamic subtest vcs1: SUCCESS (2.043s)
[481.934268] Starting dynamic subtest: vecs0
[483.910789] Dynamic subtest vecs0: SUCCESS (1.985s)
[483.924191] Starting dynamic subtest: ccs0
[485.912242] Dynamic subtest ccs0: SUCCESS (1.999s)
[485.914844] Subtest clean: SUCCESS (6.239s)
[486.185101] [115/133] (543s left) kms_invalid_mode (bad-vsync-start)
[486.281189] Starting subtest: bad-vsync-start
[486.283418] Starting dynamic subtest: pipe-A-eDP-1
[486.568593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[486.582103] Starting dynamic subtest: pipe-B-eDP-1
[486.584230] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[486.594054] Starting dynamic subtest: pipe-C-eDP-1
[486.596317] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[486.617058] Starting dynamic subtest: pipe-D-eDP-1
[486.619913] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[486.622769] Subtest bad-vsync-start: SUCCESS (0.296s)
[487.385703] [116/133] (541s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[487.445366] Starting subtest: legacy-engines-hostile-preempt
[487.447676] Starting dynamic subtest: render
[487.532990] Dynamic subtest render: SUCCESS (0.086s)
[487.545733] Starting dynamic subtest: bsd1
[488.917216] Dynamic subtest bsd1: SUCCESS (1.380s)
[488.930909] Starting dynamic subtest: bsd2
[490.894470] Dynamic subtest bsd2: SUCCESS (1.973s)
[490.913244] Starting dynamic subtest: blt
[490.957670] Dynamic subtest blt: SUCCESS (0.061s)
[490.974872] Starting dynamic subtest: vebox
[492.860778] Dynamic subtest vebox: SUCCESS (1.898s)
[492.863662] Subtest legacy-engines-hostile-preempt: SUCCESS (5.415s)
[492.984888] [117/133] (536s left) gem_spin_batch (legacy-resubmit)
[493.064322] Starting subtest: legacy-resubmit
[493.066626] Starting dynamic subtest: default
[493.072090] Dynamic subtest default: SUCCESS (0.009s)
[493.085055] Starting dynamic subtest: render
[493.087413] Dynamic subtest render: SUCCESS (0.002s)
[493.098306] Starting dynamic subtest: bsd
[493.100238] Dynamic subtest bsd: SUCCESS (0.004s)
[493.110193] Starting dynamic subtest: bsd1
[493.112083] Dynamic subtest bsd1: SUCCESS (0.001s)
[493.121645] Starting dynamic subtest: bsd2
[493.123584] Dynamic subtest bsd2: SUCCESS (0.003s)
[493.133378] Starting dynamic subtest: blt
[493.135295] Dynamic subtest blt: SUCCESS (0.004s)
[493.145066] Starting dynamic subtest: vebox
[493.146917] Dynamic subtest vebox: SUCCESS (0.004s)
[493.148799] Subtest legacy-resubmit: SUCCESS (0.034s)
[493.332554] [118/133] (536s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[493.453627] Starting subtest: 4-tiled-32bpp-rotate-0
[494.788548] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.335s)
[494.947279] [119/133] (534s left) i915_query (engine-info-invalid)
[495.010485] Starting subtest: engine-info-invalid
[495.012482] Subtest engine-info-invalid: SUCCESS (0.000s)
[495.128872] [120/133] (534s left) kms_pm_rpm (package-g7)
[497.063367] Starting subtest: package-g7
[497.068776] Subtest package-g7: SKIP (0.000s)
[497.455844] [121/133] (532s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[497.568735] Starting subtest: y-tiled-64bpp-rotate-270
[497.573387] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[497.668116] [122/133] (531s left) kms_psr (fbc-psr2-primary-render)
[497.763063] Starting subtest: fbc-psr2-primary-render
[497.765288] Starting dynamic subtest: eDP-1
[497.769520] Dynamic subtest eDP-1: SKIP (0.000s)
[497.773764] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[497.839976] [123/133] (531s left) gen9_exec_parse (unaligned-jump)
[497.900208] Subtest unaligned-jump: SKIP (0.000s)
[497.969180] [124/133] (531s left) kms_prop_blob (blob-prop-lifetime)
[498.029691] Starting subtest: blob-prop-lifetime
[498.031941] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[498.134777] [125/133] (531s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[498.248668] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[498.252703] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[498.363474] [126/133] (531s left) kms_cursor_legacy (forked-move)
[498.478731] Starting subtest: forked-move
[498.481386] Starting dynamic subtest: pipe-A
[503.937626] Dynamic subtest pipe-A: SUCCESS (5.455s)
[503.955608] Starting dynamic subtest: pipe-B
[509.410303] Dynamic subtest pipe-B: SUCCESS (5.468s)
[509.425086] Starting dynamic subtest: pipe-C
[514.875973] Dynamic subtest pipe-C: SUCCESS (5.465s)
[514.890937] Starting dynamic subtest: pipe-D
[520.348902] Dynamic subtest pipe-D: SUCCESS (5.469s)
[520.361239] Starting dynamic subtest: all-pipes
[525.885922] Dynamic subtest all-pipes: SUCCESS (5.535s)
[525.888673] Subtest forked-move: SUCCESS (27.404s)
[526.052718] [127/133] (503s left) gem_pwrite_snooped
[526.213483] [128/133] (503s left) kms_addfb_basic (bad-pitch-63)
[526.295734] Starting subtest: bad-pitch-63
[526.297729] Subtest bad-pitch-63: SUCCESS (0.000s)
[526.437303] [129/133] (503s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[526.523630] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[530.805694] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.285s)
[531.952583] [130/133] (498s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[532.060364] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[532.065288] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[533.186666] [131/133] (496s left) fbdev (nullptr)
[533.231997] Starting subtest: nullptr
[533.234415] Subtest nullptr: SUCCESS (0.000s)
[533.293143] [132/133] (496s left) kms_color_pipeline (plane-ctm3x4)
[533.379988] Starting subtest: plane-ctm3x4
[533.528905] Starting dynamic subtest: pipe-A-plane-0
[533.670597] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[533.682045] Starting dynamic subtest: pipe-A-plane-1
[533.803973] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[533.815211] Starting dynamic subtest: pipe-A-plane-2
[533.959615] Dynamic subtest pipe-A-plane-2: SUCCESS (0.154s)
[535.197379] Starting dynamic subtest: pipe-B-plane-0
[535.352184] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[535.363095] Starting dynamic subtest: pipe-B-plane-1
[535.485093] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[535.496216] Starting dynamic subtest: pipe-B-plane-2
[535.618626] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[536.800888] Starting dynamic subtest: pipe-C-plane-0
[536.901705] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[536.912628] Starting dynamic subtest: pipe-C-plane-1
[537.012657] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[537.023479] Starting dynamic subtest: pipe-C-plane-2
[537.124214] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[538.352957] Starting dynamic subtest: pipe-D-plane-0
[538.478480] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[538.490178] Starting dynamic subtest: pipe-D-plane-1
[538.599058] Dynamic subtest pipe-D-plane-1: SUCCESS (0.121s)
[538.610273] Starting dynamic subtest: pipe-D-plane-2
[538.755155] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[539.056774] Subtest plane-ctm3x4: SUCCESS (5.675s)
[539.918313] [133/133] (490s left) gem_exec_capture (pi)
[539.984212] Starting subtest: pi
[539.986716] Starting dynamic subtest: rcs0
[544.292932] Dynamic subtest rcs0: SUCCESS (4.311s)
[544.307653] Starting dynamic subtest: bcs0
[548.238893] Dynamic subtest bcs0: SUCCESS (3.945s)
[548.253073] Starting dynamic subtest: vcs0
[552.222701] Dynamic subtest vcs0: SUCCESS (3.980s)
[552.234890] Starting dynamic subtest: vcs1
[556.169992] Dynamic subtest vcs1: SUCCESS (3.945s)
[556.187534] Starting dynamic subtest: vecs0
[560.129326] Dynamic subtest vecs0: SUCCESS (3.957s)
[560.143383] Starting dynamic subtest: ccs0
[564.096252] Dynamic subtest ccs0: SUCCESS (3.965s)
[564.098897] Subtest pi: SUCCESS (24.116s)
[564.178095] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_module_load
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_busy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_atomic
results: parsing output: 7/ for test: kms_lease
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_caching
results: parsing output: 10/ for test: device_reset
results: parsing output: 11/ for test: kms_cdclk
results: parsing output: 12/ for test: gem_mmap_wc
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_create
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_scaling_modes
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: i915_pm_rps
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: gem_exec_store
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: kms_cursor_edge_walk
results: parsing output: 35/ for test: gem_ctx_shared
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_async_flips
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_chamelium_hpd
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: kms_content_protection
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gen9_exec_parse
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: syncobj_eventfd
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: template
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_tiled_pread_pwrite
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: api_intel_allocator
results: parsing output: 58/ for test: kms_plane
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_fence
results: parsing output: 61/ for test: kms_selftest
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_lmem_swapping
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_plane_cursor
results: parsing output: 73/ for test: gem_exec_suspend
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: sysfs_heartbeat_interval
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: sriov_basic
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: sw_sync
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: kms_dsc
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: i915_query
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: gem_mmap_wc
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: gem_exec_params
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_plane_alpha_blend
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: gem_mmap_offset
results: parsing output: 106/ for test: gem_ctx_create
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: gem_spin_batch
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_pm_rpm
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gen9_exec_parse
results: parsing output: 123/ for test: kms_prop_blob
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: gem_pwrite_snooped
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: fbdev
results: parsing output: 131/ for test: kms_color_pipeline
results: parsing output: 132/ for test: gem_exec_capture
Done.