[61.435944] Initializing watchdogs [61.436017] /dev/watchdog0 [61.453780] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [61.464371] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [61.468126] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.470647] [001/131] (960s left) api_intel_allocator (reopen) [61.546264] Starting subtest: reopen [61.571253] Subtest reopen: SUCCESS (0.025s) [61.722903] [002/131] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [63.735857] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [63.737587] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [63.880814] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [65.911953] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [65.913712] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [66.063305] [004/131] (956s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [68.175014] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [68.270248] [005/131] (953s left) gem_mmap_wc (write-wc-read-gtt) [68.350953] Subtest write-wc-read-gtt: SKIP (0.000s) [68.423862] [006/131] (953s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [70.418523] Starting subtest: yf-tiled-addfb-size-offset-overflow [70.420550] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [70.575372] [007/131] (951s left) gem_exec_reloc (basic-cpu-wc-active) [70.715916] Subtest basic-cpu-wc-active: SKIP (0.000s) [70.784695] [008/131] (951s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [72.770799] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [72.822852] [009/131] (949s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [74.857796] Starting subtest: extended-modeset-hang-oldfb-with-reset [74.859666] Starting dynamic subtest: pipe-A [85.297640] Dynamic subtest pipe-A: SUCCESS (10.432s) [85.312619] Starting dynamic subtest: pipe-D [96.002300] Dynamic subtest pipe-D: SUCCESS (10.696s) [96.003206] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.135s) [96.181147] [010/131] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [98.199454] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [98.201232] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [98.307995] [011/131] (924s left) gem_madvise (dontneed-before-pwrite) [98.362625] Starting subtest: dontneed-before-pwrite [98.403437] Subtest dontneed-before-pwrite: SKIP (0.040s) [98.509102] [012/131] (924s left) kms_pm_dc (dc5-dpms) [101.533255] Starting subtest: dc5-dpms [102.745992] Subtest dc5-dpms: SUCCESS (1.211s) [102.846986] [013/131] (919s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [104.859069] Starting subtest: fbc-rgb565-draw-render [109.188571] Subtest fbc-rgb565-draw-render: FAIL (4.053s) [109.252042] [014/131] (913s left) gem_partial_pwrite_pread (reads-snoop) [109.328287] Subtest reads-snoop: SKIP (0.000s) [109.393184] [015/131] (913s left) gem_exec_whisper (basic-queues-forked-all) [109.478346] Starting subtest: basic-queues-forked-all [131.474678] Subtest basic-queues-forked-all: SUCCESS (21.993s) [131.699425] [016/131] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [133.693617] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [133.695259] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [133.843886] [017/131] (889s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [135.870163] Starting subtest: flip-vs-cursor-busy-crc-legacy [136.547174] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.677s) [136.729431] [018/131] (886s left) fbdev (write) [136.796636] Starting subtest: write [138.025218] Subtest write: SUCCESS (1.228s) [138.089717] [019/131] (885s left) gem_softpin (invalid) [138.178382] Starting subtest: invalid [138.191411] Subtest invalid: SUCCESS (0.013s) [138.358551] [020/131] (884s left) gem_create (create-invalid-size) [138.437057] Starting subtest: create-invalid-size [138.438037] Subtest create-invalid-size: SUCCESS (0.000s) [138.647235] [021/131] (884s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [140.646011] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [140.647734] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [140.765459] [022/131] (882s left) kms_legacy_colorkey (basic) [142.778470] Starting subtest: basic [142.779402] Starting dynamic subtest: pipe-A [142.829862] Dynamic subtest pipe-A: SUCCESS (0.052s) [142.842763] Starting dynamic subtest: pipe-B [142.843910] Dynamic subtest pipe-B: SUCCESS (0.001s) [142.859999] Starting dynamic subtest: pipe-C [142.861246] Dynamic subtest pipe-C: SUCCESS (0.000s) [142.879779] Starting dynamic subtest: pipe-D [142.881047] Dynamic subtest pipe-D: SUCCESS (0.000s) [142.882249] Subtest basic: SUCCESS (0.054s) [142.986823] [023/131] (880s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [144.963223] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [144.964162] Starting dynamic subtest: pipe-A-HDMI-A-3 [183.959244] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (8.439s) [183.974018] Starting dynamic subtest: pipe-B-HDMI-A-3 [222.613855] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (7.147s) [222.624140] Starting dynamic subtest: pipe-C-HDMI-A-3 [260.631033] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (7.298s) [260.643861] Starting dynamic subtest: pipe-D-HDMI-A-3 [298.628097] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (7.357s) [298.629094] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SUCCESS (30.246s) [302.896820] [024/131] (847s left) kms_color (legacy-gamma-reset) [304.907732] Starting subtest: legacy-gamma-reset [304.908621] Starting dynamic subtest: pipe-A-HDMI-A-3 [305.100243] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.192s) [305.125212] Starting dynamic subtest: pipe-B-HDMI-A-3 [305.141929] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.042s) [305.157829] Starting dynamic subtest: pipe-C-HDMI-A-3 [305.167729] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.025s) [305.178646] Starting dynamic subtest: pipe-D-HDMI-A-3 [305.185734] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.018s) [305.186679] Subtest legacy-gamma-reset: SUCCESS (0.279s) [305.320905] [025/131] (845s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [307.328360] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [307.329935] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [307.488743] [026/131] (843s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [309.498403] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [309.513557] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.014s) [309.653415] [027/131] (841s left) kms_selftest (drm_damage_helper) [309.730498] Starting subtest: drm_damage_helper [309.743341] Starting dynamic subtest: drm_test_damage_iter_no_damage [309.842133] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.098s) [309.868170] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [309.909430] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.067s) [309.935240] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [310.015614] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.105s) [310.041949] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [310.127225] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.110s) [310.153871] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [310.213638] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.087s) [310.241727] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [310.315566] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.101s) [310.343730] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [310.406537] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.090s) [310.434551] Starting dynamic subtest: drm_test_damage_iter_simple_damage [310.486554] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.079s) [310.514542] Starting dynamic subtest: drm_test_damage_iter_single_damage [310.600719] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.113s) [310.628554] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [310.707630] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.106s) [310.736615] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [310.783201] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.074s) [310.811853] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [310.882606] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.099s) [310.911383] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [310.977817] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.094s) [311.006833] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [311.063618] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.085s) [311.077723] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [311.165215] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.101s) [311.175748] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [311.260330] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.094s) [311.289871] Starting dynamic subtest: drm_test_damage_iter_damage [311.352617] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.092s) [311.380748] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [311.444085] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.091s) [311.474401] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [311.529857] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.084s) [311.560405] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [311.630962] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.100s) [311.660915] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [311.715698] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.084s) [311.717111] Subtest drm_damage_helper: SUCCESS (1.985s) [311.931064] [028/131] (839s left) gem_softpin (softpin) [312.012603] Starting subtest: softpin [344.422087] Subtest softpin: SUCCESS (32.406s) [344.554800] [029/131] (806s left) gem_exec_params (rel-constants-invalid-ring) [344.643102] Starting subtest: rel-constants-invalid-ring [344.644036] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [344.804354] [030/131] (806s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [344.877094] Starting subtest: etime-multi-wait-all-submitted-signaled [344.986701] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.108s) [345.115748] [031/131] (806s left) gem_eio (unwedge-stress) [345.417732] Starting subtest: unwedge-stress [387.334136] Subtest unwedge-stress: SUCCESS (41.914s) [389.462215] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true [389.465926] [032/131] (762s left) kms_cursor_crc (cursor-size-change) [391.493460] Starting subtest: cursor-size-change [391.494429] Starting dynamic subtest: pipe-A-HDMI-A-3 [392.374795] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.880s) [392.385542] Starting dynamic subtest: pipe-D-HDMI-A-3 [393.051729] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.676s) [393.052530] Subtest cursor-size-change: SUCCESS (1.558s) [393.550098] [033/131] (757s left) gem_ctx_persistence (legacy-engines-hang) [393.634602] Starting subtest: legacy-engines-hang [393.635536] Starting dynamic subtest: render [393.742074] Dynamic subtest render: SUCCESS (0.107s) [393.754625] Starting dynamic subtest: bsd1 [393.834105] Dynamic subtest bsd1: SUCCESS (0.091s) [393.863372] Starting dynamic subtest: bsd2 [393.878774] Dynamic subtest bsd2: SUCCESS (0.043s) [393.906107] Starting dynamic subtest: blt [393.937395] Dynamic subtest blt: SUCCESS (0.057s) [393.967110] Starting dynamic subtest: vebox [393.998864] Dynamic subtest vebox: SUCCESS (0.060s) [394.000142] Subtest legacy-engines-hang: SUCCESS (0.364s) [394.169016] [034/131] (757s left) gem_flink_basic (double-flink) [394.248471] Starting subtest: double-flink [394.249437] Subtest double-flink: SUCCESS (0.000s) [394.378531] [035/131] (757s left) perf_pmu (idle-no-semaphores) [394.449489] Starting subtest: idle-no-semaphores [394.450477] Starting dynamic subtest: rcs0 [394.992961] Dynamic subtest rcs0: SUCCESS (0.542s) [395.007832] Starting dynamic subtest: bcs0 [395.509173] Dynamic subtest bcs0: SUCCESS (0.515s) [395.523864] Starting dynamic subtest: vcs0 [396.024068] Dynamic subtest vcs0: SUCCESS (0.514s) [396.038886] Starting dynamic subtest: vcs1 [396.538098] Dynamic subtest vcs1: SUCCESS (0.513s) [396.552924] Starting dynamic subtest: vecs0 [397.053107] Dynamic subtest vecs0: SUCCESS (0.514s) [397.068083] Starting dynamic subtest: vecs1 [397.567486] Dynamic subtest vecs1: SUCCESS (0.514s) [397.578827] Starting dynamic subtest: ccs0 [398.081109] Dynamic subtest ccs0: SUCCESS (0.513s) [398.082713] Subtest idle-no-semaphores: SUCCESS (3.631s) [398.230197] [036/131] (753s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [400.265810] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [400.267499] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [400.423723] [037/131] (751s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [400.553270] Starting subtest: x-tiled-to-vebox-yf-tiled [400.555295] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [400.787424] [038/131] (751s left) kms_flip (2x-flip-vs-suspend-interruptible) [402.798912] Starting subtest: 2x-flip-vs-suspend-interruptible [402.814041] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.014s) [402.950824] [039/131] (749s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [403.335503] Starting subtest: parallel-dmabuf-import-out-fence [405.467630] Subtest parallel-dmabuf-import-out-fence: SUCCESS (2.132s) [405.586293] [040/131] (746s left) kms_pm_rpm (basic-rte) [405.641934] Starting subtest: basic-rte [411.893165] Subtest basic-rte: SUCCESS (6.250s) [414.202034] [041/131] (737s left) kms_setmode (basic-clone-single-crtc) [414.298510] Starting subtest: basic-clone-single-crtc [414.301442] Subtest basic-clone-single-crtc: SKIP (0.000s) [414.444427] [042/131] (737s left) api_intel_allocator (fork-simple-once) [414.529536] Starting subtest: fork-simple-once [414.572158] Subtest fork-simple-once: SUCCESS (0.043s) [414.731154] [043/131] (737s left) gem_exec_balancer (bonded-semaphore) [414.826491] Starting subtest: bonded-semaphore [414.828321] Subtest bonded-semaphore: SKIP (0.000s) [415.179907] [044/131] (737s left) gem_ctx_create (basic-files) [415.274900] Starting subtest: basic-files [417.287537] Subtest basic-files: SUCCESS (2.013s) [418.125043] [045/131] (734s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [420.168935] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [420.916287] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.748s) [421.150387] [046/131] (731s left) kms_big_fb (x-tiled-16bpp-rotate-180) [423.171961] Starting subtest: x-tiled-16bpp-rotate-180 [424.949989] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.778s) [425.107445] [047/131] (727s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [427.125727] Starting subtest: flip-vs-cursor-crc-legacy [427.651388] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.525s) [427.849592] [048/131] (724s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [429.881151] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [429.882905] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [430.050431] [049/131] (722s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [432.080969] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [432.081865] Starting dynamic subtest: pipe-A-HDMI-A-3 [432.090459] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [432.103925] Starting dynamic subtest: pipe-B-HDMI-A-3 [432.112868] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [432.127047] Starting dynamic subtest: pipe-C-HDMI-A-3 [432.135650] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [432.150070] Starting dynamic subtest: pipe-D-HDMI-A-3 [432.160282] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [432.162262] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s) [432.357918] [050/131] (720s left) kms_flip (flip-vs-panning) [434.374463] Starting subtest: flip-vs-panning [434.378793] Starting dynamic subtest: A-HDMI-A3 [442.164068] Dynamic subtest A-HDMI-A3: SUCCESS (7.785s) [442.177821] Starting dynamic subtest: B-HDMI-A3 [449.845478] Dynamic subtest B-HDMI-A3: SUCCESS (7.680s) [449.858114] Starting dynamic subtest: C-HDMI-A3 [457.524894] Dynamic subtest C-HDMI-A3: SUCCESS (7.679s) [457.538465] Starting dynamic subtest: D-HDMI-A3 [465.206360] Dynamic subtest D-HDMI-A3: SUCCESS (7.680s) [465.207408] Subtest flip-vs-panning: SUCCESS (30.833s) [465.453351] [051/131] (687s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers) [467.473885] Starting subtest: plane-downscale-factor-0-25-with-modifiers [467.474807] Starting dynamic subtest: pipe-A [468.039433] Dynamic subtest pipe-A: SKIP (0.563s) [468.053596] Starting dynamic subtest: pipe-B [468.858706] Dynamic subtest pipe-B: SKIP (0.820s) [468.873320] Starting dynamic subtest: pipe-C [469.688960] Dynamic subtest pipe-C: SKIP (0.828s) [469.703187] Starting dynamic subtest: pipe-D [470.534476] Dynamic subtest pipe-D: SKIP (0.845s) [470.536306] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (3.059s) [470.656022] [052/131] (682s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [472.666531] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [472.668319] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [472.850625] [053/131] (680s left) kms_dp_aux_dev [474.450878] [054/131] (678s left) kms_chamelium_color (ctm-0-50) [476.491599] Subtest ctm-0-50: SKIP (0.000s) [476.563746] [055/131] (676s left) gem_exec_params (larger-than-life-batch) [476.686693] Starting subtest: larger-than-life-batch [486.364129] Subtest larger-than-life-batch: SUCCESS (9.677s) [486.836471] [056/131] (666s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [488.899278] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [488.900989] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [489.069664] [057/131] (664s left) kms_cursor_legacy (single-move) [491.110143] Starting subtest: single-move [491.111045] Starting dynamic subtest: pipe-A [496.495162] Dynamic subtest pipe-A: SUCCESS (5.384s) [496.508684] Starting dynamic subtest: pipe-B [501.879523] Dynamic subtest pipe-B: SUCCESS (5.383s) [501.892835] Starting dynamic subtest: pipe-C [507.263225] Dynamic subtest pipe-C: SUCCESS (5.382s) [507.276730] Starting dynamic subtest: pipe-D [512.646886] Dynamic subtest pipe-D: SUCCESS (5.382s) [512.660320] Starting dynamic subtest: all-pipes [518.031645] Dynamic subtest all-pipes: SUCCESS (5.383s) [518.032595] Subtest single-move: SUCCESS (26.921s) [518.141005] [058/131] (635s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [520.174428] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [520.236859] [059/131] (633s left) kms_content_protection (lic-type-1) [522.313912] Starting subtest: lic-type-1 [522.634740] Subtest lic-type-1: SKIP (0.317s) [522.860594] [060/131] (630s left) kms_big_fb (4-tiled-32bpp-rotate-90) [524.873546] Starting subtest: 4-tiled-32bpp-rotate-90 [524.939803] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.064s) [525.155222] [061/131] (628s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [527.169164] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [527.171089] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [527.345815] [062/131] (626s left) gem_exec_schedule (u-semaphore-noskip) [527.480033] Starting subtest: u-semaphore-noskip [528.320528] Subtest u-semaphore-noskip: SUCCESS (0.840s) [528.715766] [063/131] (625s left) gem_mmap_gtt (basic-copy) [528.802709] Subtest basic-copy: SKIP (0.000s) [528.926007] [064/131] (624s left) i915_pm_rps (engine-order) [529.017625] Starting subtest: engine-order [540.053902] Subtest engine-order: SUCCESS (11.035s) [540.220690] [065/131] (613s left) kms_chamelium_frames (dp-crc-multiple) [542.280947] Subtest dp-crc-multiple: SKIP (0.000s) [542.390575] [066/131] (611s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [542.484459] Starting subtest: multi-wait-all-for-submit-available-submitted [542.485436] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [542.611636] [067/131] (611s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [544.644494] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [544.646833] Starting dynamic subtest: pipe-A-HDMI-A-3 [544.655962] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [544.672631] Starting dynamic subtest: pipe-B-HDMI-A-3 [544.682118] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [544.698849] Starting dynamic subtest: pipe-C-HDMI-A-3 [544.708153] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [544.724998] Starting dynamic subtest: pipe-D-HDMI-A-3 [544.734063] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [544.735981] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s) [544.914509] [068/131] (609s left) perf (non-zero-reason) [545.359765] Starting subtest: non-zero-reason [545.360753] Starting dynamic subtest: 0-rcs0 [548.413396] Dynamic subtest 0-rcs0: FAIL (2.770s) [548.414964] Subtest non-zero-reason: FAIL (2.771s) [548.485892] [069/131] (605s left) kms_psr (psr-primary-mmap-cpu) [550.505704] Subtest psr-primary-mmap-cpu: SKIP (0.000s) [550.569311] [070/131] (603s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [552.585299] Starting subtest: psr-rgb101010-draw-pwrite [552.587127] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s) [552.757883] [071/131] (601s left) gem_mmap_wc (write-read) [552.855654] Subtest write-read: SKIP (0.000s) [552.939229] [072/131] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [554.959730] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [554.961516] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [555.136909] [073/131] (599s left) syncobj_timeline (wait-zero-handles) [555.235086] Starting subtest: wait-zero-handles [555.235943] Subtest wait-zero-handles: SUCCESS (0.000s) [555.382418] [074/131] (599s left) kms_psr (fbc-psr2-cursor-plane-move) [557.403736] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s) [557.473024] [075/131] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [559.503414] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [559.505233] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [559.666768] [076/131] (595s left) dumb_buffer (invalid-bpp) [559.765809] Starting subtest: invalid-bpp [559.766766] Subtest invalid-bpp: SUCCESS (0.000s) [559.916381] [077/131] (594s left) prime_vgem (basic-fence-mmap) [560.020890] Starting subtest: basic-fence-mmap [560.023029] Subtest basic-fence-mmap: SKIP (0.000s) [560.164981] [078/131] (594s left) kms_pm_rpm (universal-planes) [564.532578] Starting subtest: universal-planes [564.533993] Starting dynamic subtest: plane-32 [572.840581] Dynamic subtest plane-32: SUCCESS (8.307s) [572.876534] Starting dynamic subtest: plane-41 [581.125603] Dynamic subtest plane-41: SUCCESS (8.282s) [581.161421] Starting dynamic subtest: plane-50 [589.437861] Dynamic subtest plane-50: SUCCESS (8.310s) [589.472377] Starting dynamic subtest: plane-59 [597.727298] Dynamic subtest plane-59: SUCCESS (8.287s) [597.761536] Starting dynamic subtest: plane-68 [606.014881] Dynamic subtest plane-68: SUCCESS (8.285s) [606.050337] Starting dynamic subtest: plane-77 [614.278198] Dynamic subtest plane-77: SUCCESS (8.260s) [614.279586] Subtest universal-planes: SUCCESS (49.746s) [615.445810] [079/131] (539s left) kms_pipe_crc_basic (disable-crc-after-crtc) [617.491834] Starting subtest: disable-crc-after-crtc [617.492816] Starting dynamic subtest: pipe-A-HDMI-A-3 [618.074071] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.581s) [618.090255] Starting dynamic subtest: pipe-B-HDMI-A-3 [618.491653] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.415s) [618.509600] Starting dynamic subtest: pipe-C-HDMI-A-3 [618.907820] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.414s) [618.926098] Starting dynamic subtest: pipe-D-HDMI-A-3 [619.322807] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.412s) [619.323726] Subtest disable-crc-after-crtc: SUCCESS (1.832s) [619.508267] [080/131] (535s left) gem_workarounds (basic-read-context) [619.620732] Starting subtest: basic-read-context [619.651893] Subtest basic-read-context: SUCCESS (0.032s) [619.815427] [081/131] (535s left) prime_busy (hang) [619.918821] Starting subtest: hang [619.921573] Starting dynamic subtest: rcs0 [645.948551] Dynamic subtest rcs0: SUCCESS (26.026s) [645.962927] Starting dynamic subtest: bcs0 [653.100985] Dynamic subtest bcs0: SUCCESS (7.152s) [653.115872] Starting dynamic subtest: vcs0 [660.091223] Dynamic subtest vcs0: SUCCESS (6.986s) [660.105404] Starting dynamic subtest: vcs1 [667.127529] Dynamic subtest vcs1: SUCCESS (7.037s) [667.141672] Starting dynamic subtest: vecs0 [674.104365] Dynamic subtest vecs0: SUCCESS (6.975s) [674.118513] Starting dynamic subtest: vecs1 [681.069174] Dynamic subtest vecs1: SUCCESS (6.965s) [681.083607] Starting dynamic subtest: ccs0 [694.966992] Dynamic subtest ccs0: SUCCESS (13.895s) [694.968005] Subtest hang: SUCCESS (75.045s) [695.097463] [082/131] (459s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [697.118190] Starting subtest: fbc-1p-primscrn-cur-indfb-move [700.092512] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.975s) [700.309014] [083/131] (454s left) syncobj_wait (wait-all-for-submit-delayed-submit) [700.394674] Starting subtest: wait-all-for-submit-delayed-submit [700.497137] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s) [700.599170] [084/131] (454s left) kms_addfb_basic (unused-pitches) [700.684735] Starting subtest: unused-pitches [700.685703] Subtest unused-pitches: SUCCESS (0.000s) [702.801996] [085/131] (452s left) gem_exec_schedule (pi-common) [703.043415] Starting subtest: pi-common [703.044739] Starting dynamic subtest: rcs0 [703.151256] Dynamic subtest rcs0: SUCCESS (0.107s) [703.184997] Starting dynamic subtest: bcs0 [703.262017] Dynamic subtest bcs0: SUCCESS (0.108s) [703.277397] Starting dynamic subtest: vcs0 [703.345608] Dynamic subtest vcs0: SUCCESS (0.083s) [703.361391] Starting dynamic subtest: vcs1 [703.427341] Dynamic subtest vcs1: SUCCESS (0.081s) [703.447338] Starting dynamic subtest: vecs0 [703.510035] Dynamic subtest vecs0: SUCCESS (0.081s) [703.536722] Starting dynamic subtest: vecs1 [703.598263] Dynamic subtest vecs1: SUCCESS (0.087s) [703.617270] Starting dynamic subtest: ccs0 [703.680475] Dynamic subtest ccs0: SUCCESS (0.081s) [703.681632] Subtest pi-common: SUCCESS (0.638s) [703.954606] [086/131] (451s left) kms_vrr (flipline) [705.966093] Starting subtest: flipline [705.968863] Subtest flipline: SKIP (0.000s) [706.076919] [087/131] (449s left) gem_ringfill (legacy-basic) [706.498262] Starting subtest: legacy-basic [706.501919] Starting dynamic subtest: default [706.605894] Dynamic subtest default: SUCCESS (0.106s) [706.622784] Starting dynamic subtest: render [706.647917] Dynamic subtest render: SUCCESS (0.040s) [706.667821] Starting dynamic subtest: bsd [706.689867] Dynamic subtest bsd: SUCCESS (0.040s) [706.712045] Starting dynamic subtest: bsd1 [706.732883] Dynamic subtest bsd1: SUCCESS (0.041s) [706.755068] Starting dynamic subtest: bsd2 [706.775846] Dynamic subtest bsd2: SUCCESS (0.041s) [706.795266] Starting dynamic subtest: blt [706.819844] Dynamic subtest blt: SUCCESS (0.042s) [706.841263] Starting dynamic subtest: vebox [706.863076] Dynamic subtest vebox: SUCCESS (0.041s) [706.864209] Subtest legacy-basic: SUCCESS (0.366s) [707.022985] [088/131] (448s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [709.018874] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [709.019790] Starting dynamic subtest: pipe-A-HDMI-A-3 [709.029488] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [709.049107] Starting dynamic subtest: pipe-B-HDMI-A-3 [709.059572] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [709.080717] Starting dynamic subtest: pipe-C-HDMI-A-3 [709.090551] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [709.111724] Starting dynamic subtest: pipe-D-HDMI-A-3 [709.126273] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [709.128198] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s) [709.314891] [089/131] (446s left) i915_query (query-regions-garbage-items) [709.424874] Starting subtest: query-regions-garbage-items [709.425840] Subtest query-regions-garbage-items: SUCCESS (0.000s) [709.577423] [090/131] (446s left) i915_pm_rpm (gem-evict-pwrite) [714.543393] Starting subtest: gem-evict-pwrite [714.546252] Subtest gem-evict-pwrite: SKIP (0.000s) [715.688411] [091/131] (440s left) gem_mmap_offset (mmap-boundaries) [715.810542] Starting subtest: mmap-boundaries [715.811515] Starting dynamic subtest: lmem0 [715.933878] Dynamic subtest lmem0: SUCCESS (0.124s) [715.951286] Starting dynamic subtest: smem0 [717.814702] Dynamic subtest smem0: SUCCESS (1.880s) [717.815765] Subtest mmap-boundaries: SUCCESS (2.006s) [718.142414] [092/131] (437s left) gen9_exec_parse (bb-chained) [718.279753] Subtest bb-chained: SKIP (0.000s) [718.366487] [093/131] (437s left) sysfs_timeslice_duration (duration) [718.498820] Starting subtest: duration [718.501446] Starting dynamic subtest: vecs0 [731.645787] Dynamic subtest vecs0: SUCCESS (13.145s) [731.662015] Starting dynamic subtest: ccs0 [744.750662] Dynamic subtest ccs0: SUCCESS (13.101s) [744.770523] Starting dynamic subtest: vcs0 [757.932517] Dynamic subtest vcs0: SUCCESS (13.178s) [757.948802] Starting dynamic subtest: bcs0 [771.075791] Dynamic subtest bcs0: SUCCESS (13.140s) [771.092308] Starting dynamic subtest: vecs1 [784.225790] Dynamic subtest vecs1: SUCCESS (13.146s) [784.241922] Starting dynamic subtest: rcs0 [797.370753] Dynamic subtest rcs0: SUCCESS (13.142s) [797.386800] Starting dynamic subtest: vcs1 [810.518779] Dynamic subtest vcs1: SUCCESS (13.145s) [810.520347] Subtest duration: SUCCESS (92.018s) [810.617266] [094/131] (345s left) kms_psr (psr2-primary-render) [812.628665] Subtest psr2-primary-render: SKIP (0.000s) [812.695355] [095/131] (343s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [814.714649] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [814.730246] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s) [814.880968] [096/131] (341s left) gem_exec_fence (syncobj-channel) [815.443438] Starting subtest: syncobj-channel [816.475448] Subtest syncobj-channel: SUCCESS (1.032s) [816.806246] [097/131] (339s left) api_intel_bb (object-noreloc-keep-cache-simple) [816.930789] Starting subtest: object-noreloc-keep-cache-simple [816.962368] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.032s) [817.250543] [098/131] (338s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [817.436709] Starting subtest: invalid-multi-wait-unsubmitted-signaled [817.437721] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [817.688648] [099/131] (338s left) syncobj_timeline (etime-single-wait-all-submitted) [817.811098] Starting subtest: etime-single-wait-all-submitted [817.913334] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s) [818.046029] [100/131] (338s left) gem_ctx_persistence (hostile) [818.138210] Starting subtest: hostile [828.287004] Subtest hostile: SUCCESS (10.145s) [828.424715] [101/131] (328s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [830.453095] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [830.454835] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [830.615133] [102/131] (325s left) kms_cursor_crc (cursor-onscreen-128x42) [832.809889] Starting subtest: cursor-onscreen-128x42 [832.815250] Starting dynamic subtest: pipe-A-HDMI-A-3 [835.251858] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.437s) [835.287843] Starting dynamic subtest: pipe-D-HDMI-A-3 [837.804116] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.529s) [837.804961] Subtest cursor-onscreen-128x42: SUCCESS (4.994s) [838.133993] [103/131] (318s left) kms_atomic_interruptible (legacy-setmode) [840.122779] Starting subtest: legacy-setmode [840.123699] Starting dynamic subtest: pipe-A-HDMI-A-3 [846.303779] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.180s) [846.304671] Subtest legacy-setmode: SUCCESS (6.181s) [846.449347] [104/131] (310s left) kms_cursor_crc (cursor-sliding-256x85) [848.690843] Starting subtest: cursor-sliding-256x85 [848.696287] Starting dynamic subtest: pipe-A-HDMI-A-3 [853.041190] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.345s) [853.079308] Starting dynamic subtest: pipe-D-HDMI-A-3 [857.194353] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.127s) [857.195397] Subtest cursor-sliding-256x85: SUCCESS (8.504s) [857.447239] [105/131] (299s left) kms_big_fb (x-tiled-64bpp-rotate-90) [859.472298] Starting subtest: x-tiled-64bpp-rotate-90 [859.530531] Subtest x-tiled-64bpp-rotate-90: SKIP (0.059s) [859.712589] [106/131] (297s left) gem_exec_fence (nb-await) [859.928286] Starting subtest: nb-await [859.929228] Starting dynamic subtest: rcs0 [860.020465] Dynamic subtest rcs0: SUCCESS (0.092s) [860.034677] Starting dynamic subtest: bcs0 [860.082264] Dynamic subtest bcs0: SUCCESS (0.061s) [860.116278] Starting dynamic subtest: vcs0 [860.153926] Dynamic subtest vcs0: SUCCESS (0.070s) [860.187552] Starting dynamic subtest: vcs1 [860.228866] Dynamic subtest vcs1: SUCCESS (0.073s) [860.261696] Starting dynamic subtest: vecs0 [860.301166] Dynamic subtest vecs0: SUCCESS (0.070s) [860.316990] Starting dynamic subtest: vecs1 [860.363962] Dynamic subtest vecs1: SUCCESS (0.061s) [860.392370] Starting dynamic subtest: ccs0 [860.431766] Dynamic subtest ccs0: SUCCESS (0.066s) [860.433076] Subtest nb-await: SUCCESS (0.504s) [861.157180] [107/131] (295s left) perf (create-destroy-userspace-config) [861.382948] Starting subtest: create-destroy-userspace-config [861.412926] Subtest create-destroy-userspace-config: SUCCESS (0.029s) [861.479222] [108/131] (295s left) kms_psr (pr-cursor-plane-onoff) [863.481703] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [863.547466] [109/131] (293s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [865.575542] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [865.577438] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [865.742170] [110/131] (291s left) gem_pread (snoop) [865.846541] Subtest snoop: SKIP (0.000s) [865.936102] [111/131] (291s left) drm_fdinfo (memory-info-idle) [866.015944] Starting subtest: memory-info-idle [866.016983] Starting dynamic subtest: lmem0 [866.090700] Dynamic subtest lmem0: SUCCESS (0.074s) [866.104573] Starting dynamic subtest: smem0 [866.127406] Dynamic subtest smem0: SUCCESS (0.036s) [866.128448] Subtest memory-info-idle: SUCCESS (0.112s) [866.258844] [112/131] (290s left) syncobj_timeline (single-wait-all-signaled) [866.345421] Starting subtest: single-wait-all-signaled [866.346380] Subtest single-wait-all-signaled: SUCCESS (0.000s) [866.473767] [113/131] (290s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [868.474543] Starting subtest: 2x-cursor-vs-flip-legacy [868.477633] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s) [868.581704] [114/131] (288s left) gem_huc_copy (huc-copy) [868.731958] Starting subtest: huc-copy [868.737320] Subtest huc-copy: SUCCESS (0.005s) [868.922888] [115/131] (288s left) gem_mmap_gtt (hang-user) [869.007534] Subtest hang-user: SKIP (0.000s) [869.077464] [116/131] (288s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [869.178848] Subtest no-spare-fences-interruptible: SKIP (0.000s) [869.258119] [117/131] (288s left) kms_addfb_basic (basic-y-tiled-legacy) [869.345043] Starting subtest: basic-y-tiled-legacy [869.346771] Subtest basic-y-tiled-legacy: SKIP (0.000s) [871.489284] [118/131] (286s left) gem_cs_tlb (engines) [871.599458] Starting subtest: engines [871.600501] Starting dynamic subtest: rcs0 [873.753510] Dynamic subtest rcs0: SUCCESS (2.153s) [873.768940] Starting dynamic subtest: bcs0 [875.908541] Dynamic subtest bcs0: SUCCESS (2.154s) [875.924689] Starting dynamic subtest: vcs0 [878.063221] Dynamic subtest vcs0: SUCCESS (2.153s) [878.077819] Starting dynamic subtest: vcs1 [880.217110] Dynamic subtest vcs1: SUCCESS (2.153s) [880.232165] Starting dynamic subtest: vecs0 [882.370582] Dynamic subtest vecs0: SUCCESS (2.152s) [882.385351] Starting dynamic subtest: vecs1 [884.524421] Dynamic subtest vecs1: SUCCESS (2.153s) [884.539453] Starting dynamic subtest: ccs0 [886.678464] Dynamic subtest ccs0: SUCCESS (2.153s) [886.679432] Subtest engines: SUCCESS (15.078s) [886.846991] [119/131] (270s left) kms_universal_plane (universal-plane-sanity) [888.864461] Starting subtest: universal-plane-sanity [888.865354] Starting dynamic subtest: pipe-A-HDMI-A-3 [889.422469] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.556s) [889.437480] Starting dynamic subtest: pipe-B-HDMI-A-3 [889.805649] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.382s) [889.822024] Starting dynamic subtest: pipe-C-HDMI-A-3 [890.189596] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.382s) [890.206172] Starting dynamic subtest: pipe-D-HDMI-A-3 [890.575536] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.383s) [890.576542] Subtest universal-plane-sanity: SUCCESS (1.712s) [890.744091] [120/131] (267s left) syncobj_wait (multi-wait-signaled) [890.826336] Starting subtest: multi-wait-signaled [890.827237] Subtest multi-wait-signaled: SUCCESS (0.000s) [890.984408] [121/131] (266s left) kms_invalid_mode (overflow-vrefresh) [892.996220] Starting subtest: overflow-vrefresh [892.997203] Starting dynamic subtest: pipe-A-HDMI-A-3 [893.041517] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.045s) [893.058965] Starting dynamic subtest: pipe-B-HDMI-A-3 [893.060047] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [893.075664] Starting dynamic subtest: pipe-C-HDMI-A-3 [893.076610] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [893.092282] Starting dynamic subtest: pipe-D-HDMI-A-3 [893.093265] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [893.094272] Subtest overflow-vrefresh: SUCCESS (0.055s) [893.247779] [122/131] (264s left) kms_fbcon_fbt (fbc-suspend) [893.338707] Starting subtest: fbc-suspend [946.177003] Subtest fbc-suspend: SUCCESS (21.059s) [947.265508] [123/131] (243s left) kms_hdr (static-toggle-dpms) [949.284718] Starting subtest: static-toggle-dpms [949.287400] Subtest static-toggle-dpms: SKIP (0.000s) [949.394663] [124/131] (241s left) gem_userptr_blits (sync-unmap-cycles) [949.521424] Starting subtest: sync-unmap-cycles [954.895849] Subtest sync-unmap-cycles: SUCCESS (5.374s) [955.078992] [125/131] (235s left) gem_spin_batch (user-each) [955.177640] Starting subtest: user-each [958.590827] Subtest user-each: SUCCESS (3.413s) [958.884839] [126/131] (232s left) gem_exec_reloc (basic-wc-cpu-noreloc) [958.972735] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [959.038102] [127/131] (232s left) template (b) [959.115661] Starting subtest: B [959.116691] Subtest B: SUCCESS (0.000s) [959.264719] [128/131] (231s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [961.288578] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [961.289514] Starting dynamic subtest: pipe-A-valid-mode [962.158582] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.847s) [962.159564] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (0.849s) [962.351178] [129/131] (228s left) kms_psr (fbc-psr2-primary-blt) [964.128919] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [964.195470] [130/131] (227s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [965.997510] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [965.998439] Starting dynamic subtest: pipe-A [968.000243] Dynamic subtest pipe-A: SUCCESS (1.969s) [968.019416] Starting dynamic subtest: pipe-B [970.034892] Dynamic subtest pipe-B: SUCCESS (2.006s) [970.062538] Starting dynamic subtest: pipe-C [970.261787] Dynamic subtest pipe-C: SUCCESS (0.222s) [970.296027] Starting dynamic subtest: pipe-D [970.507339] Dynamic subtest pipe-D: SUCCESS (0.241s) [970.508627] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.445s) [970.726894] [131/131] (220s left) gem_wait (busy) [970.826790] Starting subtest: busy [970.827763] Starting dynamic subtest: all-engines [971.406762] Dynamic subtest all-engines: SUCCESS (0.573s) [971.420586] Starting dynamic subtest: rcs0 [971.945554] Dynamic subtest rcs0: SUCCESS (0.533s) [971.958901] Starting dynamic subtest: bcs0 [972.484494] Dynamic subtest bcs0: SUCCESS (0.533s) [972.498255] Starting dynamic subtest: vcs0 [973.022748] Dynamic subtest vcs0: SUCCESS (0.533s) [973.036103] Starting dynamic subtest: vcs1 [973.561771] Dynamic subtest vcs1: SUCCESS (0.534s) [973.575274] Starting dynamic subtest: vecs0 [974.100694] Dynamic subtest vecs0: SUCCESS (0.534s) [974.114017] Starting dynamic subtest: vecs1 [974.639655] Dynamic subtest vecs1: SUCCESS (0.534s) [974.652973] Starting dynamic subtest: ccs0 [975.179565] Dynamic subtest ccs0: SUCCESS (0.536s) [975.180505] Subtest busy: SUCCESS (4.318s) [975.431900] Closing watchdogs results: parsing output: 0/ for test: api_intel_allocator results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_chamelium_hpd results: parsing output: 4/ for test: gem_mmap_wc results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: gem_exec_reloc results: parsing output: 7/ for test: kms_psr2_sf results: parsing output: 8/ for test: kms_busy results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_madvise results: parsing output: 11/ for test: kms_pm_dc results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gem_partial_pwrite_pread results: parsing output: 14/ for test: gem_exec_whisper results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_cursor_legacy results: parsing output: 17/ for test: fbdev results: parsing output: 18/ for test: gem_softpin results: parsing output: 19/ for test: gem_create results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_legacy_colorkey results: parsing output: 22/ for test: kms_ccs results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: kms_selftest results: parsing output: 27/ for test: gem_softpin results: parsing output: 28/ for test: gem_exec_params results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: gem_eio results: parsing output: 31/ for test: kms_cursor_crc results: parsing output: 32/ for test: gem_ctx_persistence results: parsing output: 33/ for test: gem_flink_basic results: parsing output: 34/ for test: perf_pmu results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_render_copy results: parsing output: 37/ for test: kms_flip results: parsing output: 38/ for test: gem_exec_balancer results: parsing output: 39/ for test: kms_pm_rpm results: parsing output: 40/ for test: kms_setmode results: parsing output: 41/ for test: api_intel_allocator results: parsing output: 42/ for test: gem_exec_balancer results: parsing output: 43/ for test: gem_ctx_create results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_cursor_legacy results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_flip results: parsing output: 50/ for test: kms_plane_scaling results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_dp_aux_dev results: parsing output: 53/ for test: kms_chamelium_color results: parsing output: 54/ for test: gem_exec_params results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: kms_psr2_sf results: parsing output: 58/ for test: kms_content_protection results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: gem_exec_schedule results: parsing output: 62/ for test: gem_mmap_gtt results: parsing output: 63/ for test: i915_pm_rps results: parsing output: 64/ for test: kms_chamelium_frames results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: perf results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_mmap_wc results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: dumb_buffer results: parsing output: 76/ for test: prime_vgem results: parsing output: 77/ for test: kms_pm_rpm results: parsing output: 78/ for test: kms_pipe_crc_basic results: parsing output: 79/ for test: gem_workarounds results: parsing output: 80/ for test: prime_busy results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_wait results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: gem_exec_schedule results: parsing output: 85/ for test: kms_vrr results: parsing output: 86/ for test: gem_ringfill results: parsing output: 87/ for test: kms_ccs results: parsing output: 88/ for test: i915_query results: parsing output: 89/ for test: i915_pm_rpm results: parsing output: 90/ for test: gem_mmap_offset results: parsing output: 91/ for test: gen9_exec_parse results: parsing output: 92/ for test: sysfs_timeslice_duration results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: gem_exec_fence results: parsing output: 96/ for test: api_intel_bb results: parsing output: 97/ for test: syncobj_wait results: parsing output: 98/ for test: syncobj_timeline results: parsing output: 99/ for test: gem_ctx_persistence results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_cursor_crc results: parsing output: 102/ for test: kms_atomic_interruptible results: parsing output: 103/ for test: kms_cursor_crc results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: gem_exec_fence results: parsing output: 106/ for test: perf results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_pread results: parsing output: 110/ for test: drm_fdinfo results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: kms_cursor_legacy results: parsing output: 113/ for test: gem_huc_copy results: parsing output: 114/ for test: gem_mmap_gtt results: parsing output: 115/ for test: gem_fenced_exec_thrash results: parsing output: 116/ for test: kms_addfb_basic results: parsing output: 117/ for test: gem_cs_tlb results: parsing output: 118/ for test: kms_universal_plane results: parsing output: 119/ for test: syncobj_wait results: parsing output: 120/ for test: kms_invalid_mode results: parsing output: 121/ for test: kms_fbcon_fbt results: parsing output: 122/ for test: kms_hdr results: parsing output: 123/ for test: gem_userptr_blits results: parsing output: 124/ for test: gem_spin_batch results: parsing output: 125/ for test: gem_exec_reloc results: parsing output: 126/ for test: template results: parsing output: 127/ for test: kms_flip_scaled_crc results: parsing output: 128/ for test: kms_psr results: parsing output: 129/ for test: kms_plane_scaling results: parsing output: 130/ for test: gem_wait Done.