[56.917928] Initializing watchdogs
[56.918083]   /dev/watchdog0
[56.933252] [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]
[56.937955] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.940125] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.943359] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[57.066549] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[64.107451] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.101s)
[64.232904] [002/133] (953s left) i915_module_load (reload-no-display)
[64.275207] Starting subtest: reload-no-display
[70.594350] Subtest reload-no-display: SUCCESS (6.339s)
[70.621709] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[70.624734] [003/133] (946s left) gem_exec_balancer (indices)
[72.145854] Starting subtest: indices
[74.869199] Subtest indices: SUCCESS (2.727s)
[75.139212] [FACT gem_exec_balancer (indices)] new: kernel.kmod_is_loaded.i915: true
[75.142766] [004/133] (942s left) kms_busy (basic-hang)
[75.247314] Starting subtest: basic-hang
[75.249598] Starting dynamic subtest: flip-pipe-A
[75.888057] Dynamic subtest flip-pipe-A: SUCCESS (0.640s)
[75.897676] Starting dynamic subtest: modeset-pipe-A
[79.316736] Dynamic subtest modeset-pipe-A: SUCCESS (3.429s)
[79.325192] Starting dynamic subtest: flip-pipe-D
[80.518164] Dynamic subtest flip-pipe-D: SUCCESS (1.201s)
[80.527788] Starting dynamic subtest: modeset-pipe-D
[83.951049] Dynamic subtest modeset-pipe-D: SUCCESS (3.431s)
[83.953367] Subtest basic-hang: SUCCESS (8.704s)
[84.740679] [005/133] (932s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[84.848521] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[89.535706] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.692s)
[90.660167] [006/133] (926s left) gem_exec_schedule (implicit-read-write)
[90.739603] Starting subtest: implicit-read-write
[90.741875] Starting dynamic subtest: rcs0
[90.849551] Dynamic subtest rcs0: SUCCESS (0.122s)
[90.860369] Starting dynamic subtest: vcs0
[90.950352] Dynamic subtest vcs0: SUCCESS (0.101s)
[90.960048] Starting dynamic subtest: vcs1
[91.033630] Dynamic subtest vcs1: SUCCESS (0.082s)
[91.041355] Starting dynamic subtest: vecs0
[91.118058] Dynamic subtest vecs0: SUCCESS (0.083s)
[91.130932] Starting dynamic subtest: ccs0
[91.201457] Dynamic subtest ccs0: SUCCESS (0.084s)
[91.203822] Subtest implicit-read-write: SUCCESS (0.474s)
[92.964320] [007/133] (924s left) kms_atomic (plane-overlay-legacy)
[93.047912] Starting subtest: plane-overlay-legacy
[93.050246] Starting dynamic subtest: pipe-A-eDP-1
[93.489087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[93.491397] Subtest plane-overlay-legacy: SUCCESS (0.442s)
[94.288048] [008/133] (923s left) kms_lease (cursor-implicit-plane)
[94.391284] Starting subtest: cursor-implicit-plane
[94.393316] Starting dynamic subtest: pipe-A-eDP-1
[94.853618] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[94.862966] Starting dynamic subtest: pipe-B-eDP-1
[96.011638] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s)
[96.022365] Starting dynamic subtest: pipe-C-eDP-1
[97.114880] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[97.124015] Starting dynamic subtest: pipe-D-eDP-1
[98.242915] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[98.245304] Subtest cursor-implicit-plane: SUCCESS (3.854s)
[99.127583] [009/133] (918s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[99.225667] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[99.229865] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[99.319107] [010/133] (918s left) gem_caching (writes)
[99.369928] Subtest writes: SKIP (0.000s)
[99.424265] [011/133] (918s left) device_reset (unbind-cold-reset-rebind)
[99.476837] Starting subtest: unbind-cold-reset-rebind
[99.481570] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[99.549426] [012/133] (918s left) kms_cdclk (mode-transition-all-outputs)
[99.640396] Starting subtest: mode-transition-all-outputs
[99.932822] Subtest mode-transition-all-outputs: SKIP (0.291s)
[100.724654] [013/133] (917s left) gem_mmap_wc (pf-nonblock)
[100.792125] Subtest pf-nonblock: SKIP (0.000s)
[100.851873] [014/133] (917s left) perf (i915-ref-count)
[100.910686] Starting subtest: i915-ref-count
[100.985587] Subtest i915-ref-count: SUCCESS (0.072s)
[101.038696] [015/133] (916s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[101.147399] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[101.149693] Starting dynamic subtest: A-eDP1
[104.762459] Dynamic subtest A-eDP1: SUCCESS (3.614s)
[104.771413] Starting dynamic subtest: B-eDP1
[107.967332] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[107.978735] Starting dynamic subtest: C-eDP1
[111.065647] Dynamic subtest C-eDP1: SUCCESS (3.097s)
[111.078935] Starting dynamic subtest: D-eDP1
[114.154292] Dynamic subtest D-eDP1: SUCCESS (3.089s)
[114.156820] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.012s)
[114.961583] [016/133] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[115.052490] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[115.056788] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[115.143937] [017/133] (902s left) gem_create (create-ext-cpu-access-big)
[115.309243] Starting subtest: create-ext-cpu-access-big
[115.313812] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[115.396191] [018/133] (902s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[115.507986] Starting subtest: cursorB-vs-flipA-varying-size
[115.512483] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[115.652164] [019/133] (902s left) kms_psr (fbc-psr-cursor-plane-move)
[115.741041] Starting subtest: fbc-psr-cursor-plane-move
[115.743118] Starting dynamic subtest: eDP-1
[115.747480] Dynamic subtest eDP-1: SKIP (0.000s)
[115.751730] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[115.809198] [020/133] (902s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[115.866277] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[115.870650] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[116.057325] [021/133] (902s left) kms_scaling_modes (scaling-mode-full)
[116.139040] Starting subtest: scaling-mode-full
[116.141694] Starting dynamic subtest: pipe-A-eDP-1
[116.229198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[116.238980] Starting dynamic subtest: pipe-B-eDP-1
[117.390989] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.161s)
[117.400472] Starting dynamic subtest: pipe-C-eDP-1
[118.499056] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[118.507243] Starting dynamic subtest: pipe-D-eDP-1
[119.639713] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[119.642206] Subtest scaling-mode-full: SUCCESS (3.504s)
[120.800845] [022/133] (897s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[120.899441] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[128.372857] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.477s)
[128.483275] [023/133] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[128.588282] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[135.176063] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.590s)
[135.297033] [024/133] (883s left) gem_exec_reloc (basic-wc-gtt-active)
[135.359514] Subtest basic-wc-gtt-active: SKIP (0.000s)
[135.418012] [025/133] (882s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[135.512421] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[135.516507] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[135.608425] [026/133] (882s left) kms_plane_scaling (invalid-num-scalers)
[135.694986] Starting subtest: invalid-num-scalers
[135.697380] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[135.713856] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[135.722596] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[135.744469] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[135.752758] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[135.776789] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[135.784501] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[135.806706] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[135.809022] Subtest invalid-num-scalers: SUCCESS (0.114s)
[135.907174] [027/133] (882s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[136.006410] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[136.010433] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[136.096996] [028/133] (882s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[136.192473] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[142.392295] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.202s)
[143.538282] [029/133] (874s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[143.652589] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[143.656830] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[143.745190] [030/133] (874s left) kms_cursor_crc (cursor-offscreen-64x21)
[143.917688] Starting subtest: cursor-offscreen-64x21
[143.963920] Subtest cursor-offscreen-64x21: SKIP (0.041s)
[144.203537] [031/133] (874s left) i915_pm_rps (min-max-config-idle)
[144.260111] Starting subtest: min-max-config-idle
[144.264255] Subtest min-max-config-idle: SKIP (0.000s)
[144.351894] [032/133] (874s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[144.394506] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[144.499493] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[144.584559] [033/133] (874s left) gem_exec_store (pages)
[144.652654] Starting subtest: pages
[144.655063] Starting dynamic subtest: rcs0
[144.744268] Dynamic subtest rcs0: SUCCESS (0.091s)
[144.754830] Starting dynamic subtest: bcs0
[144.816271] Dynamic subtest bcs0: SUCCESS (0.070s)
[144.826405] Starting dynamic subtest: vcs0
[144.888700] Dynamic subtest vcs0: SUCCESS (0.072s)
[144.895963] Starting dynamic subtest: vcs1
[144.956225] Dynamic subtest vcs1: SUCCESS (0.067s)
[144.968723] Starting dynamic subtest: vecs0
[145.024229] Dynamic subtest vecs0: SUCCESS (0.067s)
[145.033213] Starting dynamic subtest: ccs0
[145.097051] Dynamic subtest ccs0: SUCCESS (0.072s)
[145.099391] Subtest pages: SUCCESS (0.445s)
[145.291350] [034/133] (873s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[145.674108] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[146.536376] [035/133] (872s left) kms_cursor_edge_walk (64x64-left-edge)
[146.621120] Starting subtest: 64x64-left-edge
[146.625546] Starting dynamic subtest: pipe-A-eDP-1
[150.123562] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s)
[150.132504] Starting dynamic subtest: pipe-D-eDP-1
[153.241776] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[153.243876] Subtest 64x64-left-edge: SUCCESS (6.622s)
[154.047174] [036/133] (864s left) gem_ctx_shared (exec-shared-gtt)
[154.106710] Starting subtest: exec-shared-gtt
[154.108961] Starting dynamic subtest: rcs0
[154.115564] Dynamic subtest rcs0: SUCCESS (0.009s)
[154.124098] Starting dynamic subtest: bcs0
[154.126231] Dynamic subtest bcs0: SUCCESS (0.008s)
[154.135036] Starting dynamic subtest: vcs0
[154.137175] Dynamic subtest vcs0: SUCCESS (0.006s)
[154.144590] Starting dynamic subtest: vcs1
[154.146536] Dynamic subtest vcs1: SUCCESS (0.007s)
[154.154323] Starting dynamic subtest: vecs0
[154.156477] Dynamic subtest vecs0: SUCCESS (0.006s)
[154.164066] Starting dynamic subtest: ccs0
[154.166247] Dynamic subtest ccs0: SUCCESS (0.005s)
[154.168336] Subtest exec-shared-gtt: SUCCESS (0.046s)
[154.347533] [037/133] (864s left) kms_flip (flip-vs-absolute-wf_vblank)
[154.436228] Starting subtest: flip-vs-absolute-wf_vblank
[154.438405] Starting dynamic subtest: A-eDP1
[163.402053] Dynamic subtest A-eDP1: SUCCESS (8.967s)
[163.411654] Starting dynamic subtest: B-eDP1
[172.327942] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[172.339187] Starting dynamic subtest: C-eDP1
[181.249089] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[181.261895] Starting dynamic subtest: D-eDP1
[190.184255] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[190.189180] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.755s)
[191.448367] [038/133] (827s left) kms_async_flips (async-flip-hang)
[191.557487] Starting subtest: async-flip-hang
[191.935837] Starting dynamic subtest: pipe-A-eDP-1
[218.355529] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.417s)
[218.730058] Starting dynamic subtest: pipe-B-eDP-1
[234.351444] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.625s)
[234.720960] Starting dynamic subtest: pipe-C-eDP-1
[250.353038] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.636s)
[250.727974] Starting dynamic subtest: pipe-D-eDP-1
[266.352929] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.628s)
[266.355492] Subtest async-flip-hang: SUCCESS (74.794s)
[267.567774] [039/133] (751s left) syncobj_timeline (wait-all-complex)
[267.633693] Starting subtest: wait-all-complex
[267.846651] Subtest wait-all-complex: SUCCESS (0.214s)
[267.920554] [040/133] (751s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[268.290039] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[269.061546] [041/133] (749s left) gem_mmap_gtt (basic-small-copy-xy)
[269.130574] Subtest basic-small-copy-XY: SKIP (0.000s)
[269.183467] [042/133] (749s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[269.316426] Starting subtest: protected-encrypted-src-copy-not-readible
[269.424572] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.110s)
[269.551883] [043/133] (749s left) gem_mmap_wc (fault-concurrent)
[269.615648] Subtest fault-concurrent: SKIP (0.000s)
[269.673452] [044/133] (749s left) kms_content_protection (suspend-resume)
[269.815332] Starting subtest: suspend-resume
[269.820046] Subtest suspend-resume: SKIP (0.000s)
[269.949234] [045/133] (749s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[270.049748] Starting subtest: psr-rgb565-draw-render
[277.074194] Subtest psr-rgb565-draw-render: SUCCESS (7.024s)
[277.210925] [046/133] (742s left) gen9_exec_parse (bb-oversize)
[277.270493] Subtest bb-oversize: SKIP (0.000s)
[277.331330] [047/133] (741s left) kms_rotation_crc (sprite-rotation-90)
[277.421139] Starting subtest: sprite-rotation-90
[277.426166] Subtest sprite-rotation-90: SKIP (0.001s)
[277.492094] [048/133] (741s left) syncobj_eventfd (invalid-illegal-eventfd)
[277.539916] Starting subtest: invalid-illegal-eventfd
[277.542207] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[277.646960] [049/133] (741s left) kms_pipe_crc_basic (bad-source)
[277.737984] Starting subtest: bad-source
[277.739853] Subtest bad-source: SUCCESS (0.000s)
[277.807926] [050/133] (741s left) template (a)
[277.874674] Starting subtest: A
[277.876577] Subtest A: SUCCESS (0.000s)
[277.968989] [051/133] (741s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[278.068060] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[278.071476] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[278.156048] [052/133] (741s left) gem_tiled_pread_pwrite
[278.261871] [053/133] (741s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[278.349482] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[278.351351] Starting dynamic subtest: pipe-A
[278.369142] Dynamic subtest pipe-A: SKIP (0.017s)
[278.378459] Starting dynamic subtest: pipe-B
[278.398971] Dynamic subtest pipe-B: SKIP (0.029s)
[278.406834] Starting dynamic subtest: pipe-C
[278.428509] Dynamic subtest pipe-C: SKIP (0.029s)
[278.435925] Starting dynamic subtest: pipe-D
[278.459451] Dynamic subtest pipe-D: SKIP (0.030s)
[278.462528] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.107s)
[278.564813] [054/133] (740s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[278.654942] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[278.658403] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[278.772694] [055/133] (740s left) kms_pm_rpm (cursor)
[281.099785] Starting subtest: cursor
[281.104585] Subtest cursor: SKIP (0.000s)
[281.480973] [056/133] (738s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[281.585363] Starting subtest: psr2-overlay-plane-update-continuous-sf
[281.587546] Starting dynamic subtest: pipe-A-eDP-1
[282.688357] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.108s)
[282.698834] Starting dynamic subtest: pipe-B-eDP-1
[284.418444] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.728s)
[284.420678] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.840s)
[285.223588] [057/133] (734s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[285.270947] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[285.273161] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[285.363655] [058/133] (734s left) api_intel_allocator (reopen-fork)
[285.414638] Starting subtest: reopen-fork
[288.748067] Subtest reopen-fork: SUCCESS (3.333s)
[288.822378] [059/133] (730s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[288.916920] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[288.942886] Starting dynamic subtest: pipe-A-plane-0
[289.231938] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[289.245448] Starting dynamic subtest: pipe-A-plane-3
[289.465069] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[289.473752] Starting dynamic subtest: pipe-A-plane-5
[289.477957] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[290.614179] Starting dynamic subtest: pipe-B-plane-0
[290.895738] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[290.903406] Starting dynamic subtest: pipe-B-plane-3
[291.128739] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[291.138888] Starting dynamic subtest: pipe-B-plane-5
[291.142921] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[291.438360] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.522s)
[292.320343] [060/133] (727s left) kms_big_fb (linear-16bpp-rotate-0)
[292.427234] Starting subtest: linear-16bpp-rotate-0
[293.728729] Subtest linear-16bpp-rotate-0: SUCCESS (1.301s)
[293.837848] [061/133] (726s left) gem_exec_fence (syncobj-timeline-signal)
[294.397718] Starting subtest: syncobj-timeline-signal
[294.404945] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[295.966715] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[295.970365] [062/133] (723s left) kms_selftest (drm_format_helper)
[296.008087] Starting subtest: drm_format_helper
[296.015875] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[296.104280] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.087s)
[296.114485] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[296.183034] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.080s)
[296.193110] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[296.284709] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.101s)
[296.293622] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[296.392269] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.107s)
[296.401509] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[296.478639] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.086s)
[296.487291] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[296.580866] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.099s)
[296.589508] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[296.675272] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.096s)
[296.683552] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[296.763265] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.086s)
[296.771114] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[296.862174] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.099s)
[296.869814] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[296.975899] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.112s)
[296.992811] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[297.078130] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.099s)
[297.086649] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[297.175891] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.098s)
[297.185239] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[297.277196] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.099s)
[297.285075] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[297.373628] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.095s)
[297.382495] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[297.465849] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.094s)
[297.475320] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[297.564824] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.098s)
[297.573453] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[297.674534] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.107s)
[297.676666] Subtest drm_format_helper: SUCCESS (1.665s)
[297.815366] [063/133] (722s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[297.913168] Starting subtest: fbc-rgb101010-draw-render
[302.510108] Subtest fbc-rgb101010-draw-render: SUCCESS (4.598s)
[303.688538] [064/133] (716s left) gem_lmem_swapping (massive-random)
[303.734749] Subtest massive-random: SKIP (0.000s)
[303.780424] [065/133] (716s left) gem_exec_schedule (preempt-user)
[303.854505] Starting subtest: preempt-user
[303.856455] Starting dynamic subtest: rcs0
[303.869465] Dynamic subtest rcs0: SUCCESS (0.022s)
[303.879157] Starting dynamic subtest: bcs0
[303.887842] Dynamic subtest bcs0: SUCCESS (0.018s)
[303.896153] Starting dynamic subtest: vcs0
[303.908680] Dynamic subtest vcs0: SUCCESS (0.020s)
[303.916982] Starting dynamic subtest: vcs1
[303.929132] Dynamic subtest vcs1: SUCCESS (0.020s)
[303.936894] Starting dynamic subtest: vecs0
[303.951486] Dynamic subtest vecs0: SUCCESS (0.022s)
[303.959650] Starting dynamic subtest: ccs0
[303.971561] Dynamic subtest ccs0: SUCCESS (0.019s)
[303.973752] Subtest preempt-user: SUCCESS (0.125s)
[306.010917] [066/133] (714s left) gem_exec_fence (keep-in-fence)
[306.191201] Starting subtest: keep-in-fence
[306.193652] Starting dynamic subtest: rcs0
[306.275983] Dynamic subtest rcs0: SUCCESS (0.084s)
[306.287079] Starting dynamic subtest: bcs0
[306.333265] Dynamic subtest bcs0: SUCCESS (0.055s)
[306.344562] Starting dynamic subtest: vcs0
[307.927081] Dynamic subtest vcs0: SUCCESS (1.590s)
[307.938367] Starting dynamic subtest: vcs1
[309.911386] Dynamic subtest vcs1: SUCCESS (1.981s)
[309.923340] Starting dynamic subtest: vecs0
[311.895358] Dynamic subtest vecs0: SUCCESS (1.982s)
[311.906754] Starting dynamic subtest: ccs0
[312.131137] Dynamic subtest ccs0: SUCCESS (0.234s)
[312.133957] Subtest keep-in-fence: SUCCESS (5.940s)
[313.957498] [067/133] (706s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[314.018584] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[314.086931] [068/133] (706s left) kms_psr (psr2-primary-page-flip)
[314.182986] Starting subtest: psr2-primary-page-flip
[314.185331] Starting dynamic subtest: eDP-1
[315.861740] Dynamic subtest eDP-1: SUCCESS (1.679s)
[315.864236] Subtest psr2-primary-page-flip: SUCCESS (1.680s)
[316.747867] [069/133] (703s left) gem_eio (in-flight-internal-10ms)
[316.955960] Starting subtest: in-flight-internal-10ms
[317.984456] Subtest in-flight-internal-10ms: SUCCESS (1.027s)
[318.120851] [070/133] (702s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[318.254247] Starting subtest: cursor-vs-flip-atomic-transitions
[348.441631] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.185s)
[349.276975] [071/133] (670s left) gem_exec_reloc (basic-gtt-wc-active)
[349.357925] Subtest basic-gtt-wc-active: SKIP (0.000s)
[349.435082] [072/133] (670s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[349.535150] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[349.537405] Starting dynamic subtest: pipe-A-eDP-1
[349.594905] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[349.605457] Starting dynamic subtest: pipe-B-eDP-1
[349.662952] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[349.672965] Starting dynamic subtest: pipe-C-eDP-1
[349.729383] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[349.739492] Starting dynamic subtest: pipe-D-eDP-1
[349.796502] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[349.800648] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[351.836470] [073/133] (668s left) kms_plane_cursor (viewport)
[351.935306] Starting subtest: viewport
[351.939825] Starting dynamic subtest: pipe-A-eDP-1-size-64
[354.476536] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.541s)
[354.535921] Starting dynamic subtest: pipe-A-eDP-1-size-128
[357.054966] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.527s)
[357.114032] Starting dynamic subtest: pipe-A-eDP-1-size-256
[359.691567] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.585s)
[360.050212] Starting dynamic subtest: pipe-B-eDP-1-size-64
[363.336728] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.296s)
[363.396995] Starting dynamic subtest: pipe-B-eDP-1-size-128
[365.837626] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.449s)
[365.898329] Starting dynamic subtest: pipe-B-eDP-1-size-256
[368.338504] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.449s)
[369.434416] Starting dynamic subtest: pipe-C-eDP-1-size-64
[371.781922] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.360s)
[371.819373] Starting dynamic subtest: pipe-C-eDP-1-size-128
[373.948552] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.136s)
[373.986182] Starting dynamic subtest: pipe-C-eDP-1-size-256
[376.070979] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.092s)
[376.401529] Starting dynamic subtest: pipe-D-eDP-1-size-64
[379.179271] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.788s)
[379.216077] Starting dynamic subtest: pipe-D-eDP-1-size-128
[381.379581] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.170s)
[381.417651] Starting dynamic subtest: pipe-D-eDP-1-size-256
[383.591281] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[383.912339] Subtest viewport: SUCCESS (31.976s)
[384.753059] [074/133] (635s left) gem_exec_suspend (basic-s4-devices)
[384.813094] Starting subtest: basic-S4-devices
[384.815326] Starting dynamic subtest: smem
[396.887298] Dynamic subtest smem: SUCCESS (12.073s)
[396.889908] Subtest basic-S4-devices: SUCCESS (12.076s)
[404.084796] [075/133] (623s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[404.226434] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[405.062082] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[405.246465] [076/133] (622s left) sysfs_heartbeat_interval (invalid)
[405.308613] Starting subtest: invalid
[405.310872] Starting dynamic subtest: vecs0
[405.313065] Dynamic subtest vecs0: SUCCESS (0.000s)
[405.323067] Starting dynamic subtest: ccs0
[405.325140] Dynamic subtest ccs0: SUCCESS (0.000s)
[405.334074] Starting dynamic subtest: vcs0
[405.335910] Dynamic subtest vcs0: SUCCESS (0.000s)
[405.344709] Starting dynamic subtest: bcs0
[405.346759] Dynamic subtest bcs0: SUCCESS (0.000s)
[405.355634] Starting dynamic subtest: rcs0
[405.357708] Dynamic subtest rcs0: SUCCESS (0.000s)
[405.366590] Starting dynamic subtest: vcs1
[405.368672] Dynamic subtest vcs1: SUCCESS (0.000s)
[405.370740] Subtest invalid: SUCCESS (0.006s)
[405.409600] [077/133] (622s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[405.662619] Starting subtest: cursor-rapid-movement-256x256
[405.664870] Starting dynamic subtest: pipe-A-eDP-1
[406.198117] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.532s)
[406.224703] Starting dynamic subtest: pipe-D-eDP-1
[407.382443] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.162s)
[407.384416] Subtest cursor-rapid-movement-256x256: SUCCESS (1.719s)
[408.231425] [078/133] (619s left) sriov_basic (enable-vfs-autoprobe-on)
[408.288489] Starting subtest: enable-vfs-autoprobe-on
[408.290669] Starting dynamic subtest: numvfs-1
[408.371278] Dynamic subtest numvfs-1: FAIL (0.030s)
[408.382591] Starting dynamic subtest: numvfs-2
[408.456663] Dynamic subtest numvfs-2: FAIL (0.003s)
[408.471322] Starting dynamic subtest: numvfs-3
[408.545231] Dynamic subtest numvfs-3: FAIL (0.003s)
[408.555847] Starting dynamic subtest: numvfs-4
[408.628602] Dynamic subtest numvfs-4: FAIL (0.003s)
[408.638880] Starting dynamic subtest: numvfs-5
[408.707268] Dynamic subtest numvfs-5: FAIL (0.004s)
[408.716987] Starting dynamic subtest: numvfs-6
[408.786133] Dynamic subtest numvfs-6: FAIL (0.004s)
[408.795457] Starting dynamic subtest: numvfs-7
[408.864564] Dynamic subtest numvfs-7: FAIL (0.004s)
[408.874027] Starting dynamic subtest: numvfs-random
[408.941728] Dynamic subtest numvfs-random: FAIL (0.003s)
[408.951841] Starting dynamic subtest: numvfs-all
[409.021677] Dynamic subtest numvfs-all: FAIL (0.507s)
[409.023601] Subtest enable-vfs-autoprobe-on: FAIL (0.570s)
[409.062589] [079/133] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[409.166399] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[409.170300] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[409.258933] [080/133] (618s left) sw_sync (alloc_fence_invalid_timeline)
[409.295173] Starting subtest: alloc_fence_invalid_timeline
[409.296897] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[409.344551] [081/133] (618s left) gem_userptr_blits (huge-split)
[409.407133] Starting subtest: huge-split
[409.414368] Subtest huge-split: SUCCESS (0.007s)
[409.532292] [082/133] (618s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[409.622976] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[413.393386] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.772s)
[414.546725] [083/133] (613s left) gem_userptr_blits (stress-mm)
[414.607989] Starting subtest: stress-mm
[419.977217] Subtest stress-mm: SUCCESS (5.369s)
[420.097707] [084/133] (607s left) perf_pmu (render-node-busy-idle)
[420.175196] Starting subtest: render-node-busy-idle
[420.177580] Starting dynamic subtest: rcs0
[420.853887] Dynamic subtest rcs0: SUCCESS (0.678s)
[420.866730] Starting dynamic subtest: bcs0
[421.520820] Dynamic subtest bcs0: SUCCESS (0.665s)
[421.533632] Starting dynamic subtest: vcs0
[422.934390] Dynamic subtest vcs0: SUCCESS (1.410s)
[422.947275] Starting dynamic subtest: vcs1
[424.918556] Dynamic subtest vcs1: SUCCESS (1.982s)
[424.931687] Starting dynamic subtest: vecs0
[426.902424] Dynamic subtest vecs0: SUCCESS (1.981s)
[426.915840] Starting dynamic subtest: ccs0
[427.565553] Dynamic subtest ccs0: SUCCESS (0.662s)
[427.568091] Subtest render-node-busy-idle: SUCCESS (7.392s)
[427.657471] [085/133] (600s left) api_intel_bb (misplaced-blitter)
[427.705083] Starting subtest: misplaced-blitter
[427.713817] Subtest misplaced-blitter: SUCCESS (0.010s)
[427.836106] [086/133] (600s left) kms_dsc (dsc-with-output-formats)
[427.931299] Starting subtest: dsc-with-output-formats
[427.952459] Subtest dsc-with-output-formats: SKIP (0.000s)
[428.018809] [087/133] (599s left) gem_exec_reloc (basic-cpu-gtt)
[428.078911] Subtest basic-cpu-gtt: SKIP (0.000s)
[428.155121] [088/133] (599s left) i915_query (query-topology-unsupported)
[428.215693] Starting subtest: query-topology-unsupported
[428.220254] Subtest query-topology-unsupported: SKIP (0.000s)
[428.330689] [089/133] (599s left) kms_psr (pr-sprite-plane-onoff)
[428.433835] Starting subtest: pr-sprite-plane-onoff
[428.438024] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[428.519568] [090/133] (599s left) kms_vblank (query-forked-busy)
[428.615620] Starting subtest: query-forked-busy
[428.617449] Starting dynamic subtest: pipe-A-eDP-1
[430.513723] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[430.529894] Starting dynamic subtest: pipe-D-eDP-1
[433.087914] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.572s)
[433.090220] Subtest query-forked-busy: SUCCESS (4.472s)
[433.885361] [091/133] (594s left) gem_render_copy (x-tiled)
[433.939277] Starting subtest: x-tiled
[433.941558] Starting dynamic subtest: smem
[433.980008] Dynamic subtest smem: SUCCESS (0.043s)
[433.982217] Subtest x-tiled: SUCCESS (0.044s)
[434.222654] [092/133] (593s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[434.356271] Starting subtest: cursorA-vs-flipA-legacy
[445.497278] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.141s)
[446.307426] [093/133] (581s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[446.378606] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[446.381045] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[446.490933] [094/133] (581s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[446.579198] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[446.583239] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[446.652727] [095/133] (581s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[446.738256] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[446.742227] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[446.812482] [096/133] (581s left) gem_mmap_wc (set-cache-level)
[446.859651] Subtest set-cache-level: SKIP (0.000s)
[446.926447] [097/133] (581s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[447.022260] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[447.024398] Starting dynamic subtest: pipe-A-eDP-1
[447.047131] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[447.060083] Starting dynamic subtest: pipe-B-eDP-1
[447.082060] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[447.091264] Starting dynamic subtest: pipe-C-eDP-1
[447.112251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[447.121498] Starting dynamic subtest: pipe-D-eDP-1
[447.143521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[447.147624] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[449.284838] [098/133] (579s left) kms_flip (dpms-vs-vblank-race-interruptible)
[449.384847] Starting subtest: dpms-vs-vblank-race-interruptible
[449.387099] Starting dynamic subtest: A-eDP1
[454.376483] Dynamic subtest A-eDP1: SUCCESS (4.987s)
[454.386857] Starting dynamic subtest: B-eDP1
[457.945928] Dynamic subtest B-eDP1: SUCCESS (3.566s)
[457.957649] Starting dynamic subtest: C-eDP1
[462.542903] Dynamic subtest C-eDP1: SUCCESS (4.596s)
[462.555300] Starting dynamic subtest: D-eDP1
[467.195575] Dynamic subtest D-eDP1: SUCCESS (4.650s)
[467.197855] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.810s)
[468.068330] [099/133] (560s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[468.121647] Starting subtest: invalid-bsd2-flag-on-vebox
[468.124447] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[468.245484] [100/133] (560s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[468.349620] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[468.353732] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[468.442947] [101/133] (560s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[468.561469] Starting subtest: short-flip-before-cursor-toggle
[469.475468] Subtest short-flip-before-cursor-toggle: SUCCESS (0.912s)
[470.309622] [102/133] (558s left) kms_plane_alpha_blend (constant-alpha-min)
[470.418923] Starting subtest: constant-alpha-min
[470.698803] Starting dynamic subtest: pipe-A-eDP-1
[471.397701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[471.407721] Starting dynamic subtest: pipe-D-eDP-1
[472.902758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.501s)
[472.905046] Subtest constant-alpha-min: SUCCESS (2.484s)
[473.753386] [103/133] (554s left) syncobj_wait (wait-all-for-submit-snapshot)
[473.820251] Starting subtest: wait-all-for-submit-snapshot
[473.900725] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[473.979237] [104/133] (554s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[474.092239] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[474.105205] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[474.218439] [105/133] (554s left) kms_addfb_basic (bad-pitch-256)
[474.281901] Starting subtest: bad-pitch-256
[474.283915] Subtest bad-pitch-256: SUCCESS (0.000s)
[474.430917] [106/133] (554s left) gem_mmap_offset (blt-coherency)
[474.502714] Starting subtest: blt-coherency
[474.509072] Subtest blt-coherency: SUCCESS (0.007s)
[474.631774] [107/133] (554s left) gem_ctx_create (basic)
[474.698412] Starting subtest: basic
[474.700470] Subtest basic: SUCCESS (0.000s)
[474.907620] [108/133] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[475.001710] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[475.006183] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[475.101838] [109/133] (553s left) perf (gen12-group-concurrent-oa-buffer-read)
[475.194686] Starting subtest: gen12-group-concurrent-oa-buffer-read
[485.217789] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.021s)
[485.259138] [110/133] (543s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[485.362066] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[485.364430] Starting dynamic subtest: pipe-A-eDP-1
[485.388083] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[485.399695] Starting dynamic subtest: pipe-B-eDP-1
[485.421695] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[485.430942] Starting dynamic subtest: pipe-C-eDP-1
[485.452914] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[485.461987] Starting dynamic subtest: pipe-D-eDP-1
[485.484069] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[485.488413] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[487.534784] [111/133] (541s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[487.634753] Starting subtest: fbcpsr-2p-rte
[487.638774] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[487.752518] [112/133] (541s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[487.850832] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[487.853106] Starting dynamic subtest: pipe-A-eDP-1
[487.936248] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[487.947323] Starting dynamic subtest: pipe-B-eDP-1
[489.116496] Dynamic subtest pipe-B-eDP-1: SKIP (1.180s)
[489.121124] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.271s)
[490.411338] [113/133] (538s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[490.510402] Starting subtest: x-tiled-16bpp-rotate-270
[490.534219] Subtest x-tiled-16bpp-rotate-270: SKIP (0.021s)
[490.634644] [114/133] (538s left) gem_ctx_isolation (clean)
[490.712624] Starting subtest: clean
[490.715066] Starting dynamic subtest: rcs0
[490.768392] Dynamic subtest rcs0: SUCCESS (0.055s)
[490.780462] Starting dynamic subtest: bcs0
[490.840037] Dynamic subtest bcs0: SUCCESS (0.070s)
[490.851618] Starting dynamic subtest: vcs0
[490.872384] Dynamic subtest vcs0: SUCCESS (0.031s)
[490.882063] Starting dynamic subtest: vcs1
[492.883373] Dynamic subtest vcs1: SUCCESS (2.010s)
[492.895263] Starting dynamic subtest: vecs0
[494.953185] Dynamic subtest vecs0: SUCCESS (2.069s)
[494.965294] Starting dynamic subtest: ccs0
[496.933870] Dynamic subtest ccs0: SUCCESS (1.980s)
[496.936422] Subtest clean: SUCCESS (6.221s)
[497.171147] [115/133] (531s left) kms_invalid_mode (bad-vsync-start)
[497.263412] Starting subtest: bad-vsync-start
[497.265681] Starting dynamic subtest: pipe-A-eDP-1
[497.543388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[497.554280] Starting dynamic subtest: pipe-B-eDP-1
[497.556512] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[497.565725] Starting dynamic subtest: pipe-C-eDP-1
[497.568038] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[497.577198] Starting dynamic subtest: pipe-D-eDP-1
[497.579474] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[497.581691] Subtest bad-vsync-start: SUCCESS (0.289s)
[498.432427] [116/133] (530s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[498.494573] Starting subtest: legacy-engines-hostile-preempt
[498.496919] Starting dynamic subtest: render
[498.583975] Dynamic subtest render: SUCCESS (0.089s)
[498.596673] Starting dynamic subtest: bsd1
[499.923957] Dynamic subtest bsd1: SUCCESS (1.335s)
[499.940186] Starting dynamic subtest: bsd2
[501.886410] Dynamic subtest bsd2: SUCCESS (1.958s)
[501.898929] Starting dynamic subtest: blt
[501.967668] Dynamic subtest blt: SUCCESS (0.080s)
[501.980226] Starting dynamic subtest: vebox
[503.890490] Dynamic subtest vebox: SUCCESS (1.918s)
[503.893249] Subtest legacy-engines-hostile-preempt: SUCCESS (5.396s)
[503.972875] [117/133] (525s left) gem_spin_batch (legacy-resubmit)
[504.043142] Starting subtest: legacy-resubmit
[504.045416] Starting dynamic subtest: default
[504.054062] Dynamic subtest default: SUCCESS (0.010s)
[504.064442] Starting dynamic subtest: render
[504.066732] Dynamic subtest render: SUCCESS (0.002s)
[504.076318] Starting dynamic subtest: bsd
[504.078210] Dynamic subtest bsd: SUCCESS (0.003s)
[504.087464] Starting dynamic subtest: bsd1
[504.089945] Dynamic subtest bsd1: SUCCESS (0.003s)
[504.099144] Starting dynamic subtest: bsd2
[504.101651] Dynamic subtest bsd2: SUCCESS (0.001s)
[504.111564] Starting dynamic subtest: blt
[504.113834] Dynamic subtest blt: SUCCESS (0.004s)
[504.122918] Starting dynamic subtest: vebox
[504.125141] Dynamic subtest vebox: SUCCESS (0.007s)
[504.127291] Subtest legacy-resubmit: SUCCESS (0.038s)
[504.301636] [118/133] (524s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[504.407373] Starting subtest: 4-tiled-32bpp-rotate-0
[505.743637] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.334s)
[505.915851] [119/133] (523s left) i915_query (engine-info-invalid)
[505.961871] Starting subtest: engine-info-invalid
[505.963848] Subtest engine-info-invalid: SUCCESS (0.000s)
[506.047429] [120/133] (523s left) kms_pm_rpm (package-g7)
[508.074387] Starting subtest: package-g7
[508.079491] Subtest package-g7: SKIP (0.000s)
[508.463351] [121/133] (520s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[508.579138] Starting subtest: y-tiled-64bpp-rotate-270
[508.583844] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[508.682150] [122/133] (520s left) kms_psr (fbc-psr2-primary-render)
[508.780503] Starting subtest: fbc-psr2-primary-render
[508.782872] Starting dynamic subtest: eDP-1
[508.787214] Dynamic subtest eDP-1: SKIP (0.000s)
[508.791246] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[508.853662] [123/133] (520s left) gen9_exec_parse (unaligned-jump)
[508.905312] Subtest unaligned-jump: SKIP (0.000s)
[508.975701] [124/133] (520s left) kms_prop_blob (blob-prop-lifetime)
[509.027094] Starting subtest: blob-prop-lifetime
[509.029237] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[509.120732] [125/133] (520s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[509.218191] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[509.222447] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[509.303911] [126/133] (520s left) kms_cursor_legacy (forked-move)
[509.423253] Starting subtest: forked-move
[509.425226] Starting dynamic subtest: pipe-A
[514.911881] Dynamic subtest pipe-A: SUCCESS (5.484s)
[514.931186] Starting dynamic subtest: pipe-B
[520.373744] Dynamic subtest pipe-B: SUCCESS (5.460s)
[520.385989] Starting dynamic subtest: pipe-C
[525.838457] Dynamic subtest pipe-C: SUCCESS (5.463s)
[525.851212] Starting dynamic subtest: pipe-D
[531.314848] Dynamic subtest pipe-D: SUCCESS (5.474s)
[531.327385] Starting dynamic subtest: all-pipes
[536.833440] Dynamic subtest all-pipes: SUCCESS (5.515s)
[536.835941] Subtest forked-move: SUCCESS (27.406s)
[536.980639] [127/133] (492s left) gem_pwrite_snooped
[537.106513] [128/133] (492s left) kms_addfb_basic (bad-pitch-63)
[537.158091] Starting subtest: bad-pitch-63
[537.159990] Subtest bad-pitch-63: SUCCESS (0.000s)
[537.279860] [129/133] (492s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[537.376758] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[541.574596] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.202s)
[542.747351] [130/133] (487s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[542.840398] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[542.845054] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[543.974010] [131/133] (485s left) fbdev (nullptr)
[544.011924] Starting subtest: nullptr
[544.014242] Subtest nullptr: SUCCESS (0.000s)
[544.068850] [132/133] (485s left) kms_color_pipeline (plane-ctm3x4)
[544.159122] Starting subtest: plane-ctm3x4
[544.304511] Starting dynamic subtest: pipe-A-plane-0
[544.448606] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[544.458958] Starting dynamic subtest: pipe-A-plane-1
[544.559739] Dynamic subtest pipe-A-plane-1: SUCCESS (0.111s)
[544.569560] Starting dynamic subtest: pipe-A-plane-2
[544.671026] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s)
[545.857985] Starting dynamic subtest: pipe-B-plane-0
[546.015807] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[546.026910] Starting dynamic subtest: pipe-B-plane-1
[546.127074] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[546.136806] Starting dynamic subtest: pipe-B-plane-2
[546.305388] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[547.500159] Starting dynamic subtest: pipe-C-plane-0
[547.600958] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[547.611091] Starting dynamic subtest: pipe-C-plane-1
[547.712669] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[547.723482] Starting dynamic subtest: pipe-C-plane-2
[547.835998] Dynamic subtest pipe-C-plane-2: SUCCESS (0.121s)
[549.019054] Starting dynamic subtest: pipe-D-plane-0
[549.121223] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[549.131763] Starting dynamic subtest: pipe-D-plane-1
[549.232304] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[549.242987] Starting dynamic subtest: pipe-D-plane-2
[549.343527] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[549.631141] Subtest plane-ctm3x4: SUCCESS (5.472s)
[550.499878] [133/133] (479s left) gem_exec_capture (pi)
[550.571405] Starting subtest: pi
[550.573835] Starting dynamic subtest: rcs0
[554.790055] Dynamic subtest rcs0: SUCCESS (4.221s)
[554.802893] Starting dynamic subtest: bcs0
[558.639074] Dynamic subtest bcs0: SUCCESS (3.848s)
[558.649480] Starting dynamic subtest: vcs0
[562.503080] Dynamic subtest vcs0: SUCCESS (3.862s)
[562.514119] Starting dynamic subtest: vcs1
[566.339794] Dynamic subtest vcs1: SUCCESS (3.835s)
[566.352502] Starting dynamic subtest: vecs0
[570.219502] Dynamic subtest vecs0: SUCCESS (3.878s)
[570.231602] Starting dynamic subtest: ccs0
[574.052074] Dynamic subtest ccs0: SUCCESS (3.830s)
[574.054773] Subtest pi: SUCCESS (23.483s)
[574.127858] 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.