[60.607380] Initializing watchdogs
[60.607428]   /dev/watchdog0
[60.622960] [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]
[60.627465] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.629741] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.631592] [001/133] (960s left) kms_setmode (invalid-clone-exclusive-crtc)
[60.687340] Starting subtest: invalid-clone-exclusive-crtc
[60.689918] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[60.769620] [002/133] (960s left) gem_exec_balancer (invalid-bonds)
[60.827138] Starting subtest: invalid-bonds
[60.828854] Subtest invalid-bonds: SKIP (0.000s)
[61.128111] [003/133] (960s left) kms_psr (fbc-psr-sprite-blt)
[61.227485] Starting subtest: fbc-psr-sprite-blt
[61.228530] Starting dynamic subtest: eDP-1
[61.230404] Dynamic subtest eDP-1: SKIP (0.000s)
[61.232257] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[61.310385] [004/133] (959s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[61.388051] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[61.389114] Starting dynamic subtest: pipe-A-eDP-1
[61.397082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[61.403436] Starting dynamic subtest: pipe-B-eDP-1
[61.410879] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[61.416758] Starting dynamic subtest: pipe-C-eDP-1
[61.423868] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[61.429438] Starting dynamic subtest: pipe-D-eDP-1
[61.436548] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[61.437381] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[63.604937] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[63.689409] Starting subtest: fbcpsr-tiling-linear
[70.323575] Subtest fbcpsr-tiling-linear: SUCCESS (6.651s)
[70.467139] [006/133] (950s left) gem_exec_nop (basic-parallel)
[70.529540] Starting subtest: basic-parallel
[86.878088] Subtest basic-parallel: SUCCESS (16.349s)
[87.113201] [007/133] (934s left) kms_feature_discovery (display-2x)
[87.214059] Starting subtest: display-2x
[87.215849] Subtest display-2x: SKIP (0.000s)
[87.277578] [008/133] (934s left) gen3_render_tiledx_blits
[87.391631] [009/133] (933s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[87.516618] Starting subtest: cursorB-vs-flipA-toggle
[87.519525] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[87.659242] [010/133] (933s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[87.706857] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[87.767123] [011/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[87.849817] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[87.851510] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[87.945409] [012/133] (933s left) gem_mmap_gtt (zero-extend)
[88.002564] Subtest zero-extend: SKIP (0.000s)
[88.056667] [013/133] (933s left) gem_ctx_persistence (legacy-engines-cleanup)
[88.117353] Starting subtest: legacy-engines-cleanup
[88.118414] Starting dynamic subtest: render
[88.195545] Dynamic subtest render: SUCCESS (0.078s)
[88.204777] Starting dynamic subtest: bsd1
[88.241316] Dynamic subtest bsd1: SUCCESS (0.045s)
[88.250807] Starting dynamic subtest: bsd2
[88.280242] Dynamic subtest bsd2: SUCCESS (0.038s)
[88.288012] Starting dynamic subtest: blt
[88.321252] Dynamic subtest blt: SUCCESS (0.040s)
[88.330734] Starting dynamic subtest: vebox
[88.367274] Dynamic subtest vebox: SUCCESS (0.044s)
[88.368600] Subtest legacy-engines-cleanup: SUCCESS (0.251s)
[88.434592] [014/133] (933s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[88.649195] Starting subtest: cursor-rapid-movement-128x42
[88.691977] Subtest cursor-rapid-movement-128x42: SKIP (0.041s)
[88.881025] [015/133] (932s left) perf_pmu (idle)
[88.916367] Starting subtest: idle
[88.917382] Starting dynamic subtest: rcs0
[89.467427] Dynamic subtest rcs0: SUCCESS (0.541s)
[89.476581] Starting dynamic subtest: bcs0
[89.979918] Dynamic subtest bcs0: SUCCESS (0.511s)
[89.988742] Starting dynamic subtest: vcs0
[90.501074] Dynamic subtest vcs0: SUCCESS (0.519s)
[90.510409] Starting dynamic subtest: vcs1
[91.017039] Dynamic subtest vcs1: SUCCESS (0.515s)
[91.026533] Starting dynamic subtest: vecs0
[91.539801] Dynamic subtest vecs0: SUCCESS (0.522s)
[91.548851] Starting dynamic subtest: ccs0
[92.060242] Dynamic subtest ccs0: SUCCESS (0.520s)
[92.061647] Subtest idle: SUCCESS (3.135s)
[92.157907] [016/133] (929s left) gem_exec_schedule (preempt-queue)
[92.222291] Subtest preempt-queue: SKIP (0.000s)
[92.521794] [017/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[92.603228] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[92.605048] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[92.717697] [018/133] (928s left) kms_plane (plane-panning-bottom-right)
[92.811462] Starting subtest: plane-panning-bottom-right
[92.812873] Starting dynamic subtest: pipe-A
[94.483226] Dynamic subtest pipe-A: SUCCESS (1.674s)
[94.489598] Starting dynamic subtest: pipe-B
[96.827609] Dynamic subtest pipe-B: SUCCESS (2.343s)
[96.828595] Subtest plane-panning-bottom-right: SUCCESS (4.019s)
[97.636533] [019/133] (924s left) dumb_buffer (create-valid-dumb)
[97.693453] Starting subtest: create-valid-dumb
[97.694495] Subtest create-valid-dumb: SUCCESS (0.000s)
[97.795780] [020/133] (923s left) kms_selftest (drm_damage_helper)
[97.831140] Starting subtest: drm_damage_helper
[97.847670] Starting dynamic subtest: drm_test_damage_iter_no_damage
[97.934439] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.092s)
[97.942178] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[98.033091] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.098s)
[98.041300] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[98.120169] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.087s)
[98.128097] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[98.200290] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.079s)
[98.207713] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[98.294759] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.094s)
[98.301881] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[98.385978] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.092s)
[98.393387] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[98.480421] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.094s)
[98.488071] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[98.566046] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.085s)
[98.573340] Starting dynamic subtest: drm_test_damage_iter_single_damage
[98.651935] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.086s)
[98.659094] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[98.749342] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.097s)
[98.756622] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[98.841059] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.092s)
[98.848507] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[98.956789] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.115s)
[98.964539] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[99.052912] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.095s)
[99.060487] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[99.141763] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.089s)
[99.149350] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[99.228041] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.085s)
[99.234925] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[99.309456] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.081s)
[99.317348] Starting dynamic subtest: drm_test_damage_iter_damage
[99.398974] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.089s)
[99.407117] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[99.494864] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.095s)
[99.501068] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[99.577582] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.082s)
[99.583766] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[99.667351] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.090s)
[99.673444] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[99.767301] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.098s)
[99.768375] Subtest drm_damage_helper: SUCCESS (1.937s)
[99.902277] [021/133] (921s left) gem_mmap_wc (pf-nonblock)
[99.949764] Subtest pf-nonblock: SKIP (0.000s)
[100.007534] [022/133] (921s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[100.097912] Starting subtest: fb-8bpc-vs-panel-8bpc
[100.098780] Starting dynamic subtest: pipe-A-eDP-1
[101.529389] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.431s)
[101.530296] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.432s)
[102.398693] [023/133] (919s left) gem_ctx_engines (execute-allforone)
[102.454972] Starting subtest: execute-allforone
[102.469997] Subtest execute-allforone: SUCCESS (0.016s)
[103.956823] [024/133] (917s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[104.039234] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[104.040127] Starting dynamic subtest: pipe-A-default-mode
[106.730560] Dynamic subtest pipe-A-default-mode: SUCCESS (2.691s)
[106.731448] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.693s)
[107.583092] [025/133] (914s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[107.960888] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[108.799300] [026/133] (913s left) gem_eio (create-ext)
[109.043997] Starting subtest: create-ext
[109.408177] Subtest create-ext: SUCCESS (0.364s)
[109.516603] [027/133] (912s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[109.575877] Starting subtest: yf-tiled-ccs-to-y-tiled
[109.578392] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[109.772038] [028/133] (912s left) gem_tiled_pread_pwrite
[109.891565] [029/133] (912s left) kms_cursor_crc (cursor-sliding-256x85)
[110.146283] Starting subtest: cursor-sliding-256x85
[110.190338] Subtest cursor-sliding-256x85: SKIP (0.042s)
[110.361274] [030/133] (911s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[110.464303] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[110.491392] Starting dynamic subtest: pipe-A-plane-0
[110.791043] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[110.798650] Starting dynamic subtest: pipe-A-plane-3
[111.024464] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[112.129820] Starting dynamic subtest: pipe-B-plane-0
[112.417491] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[112.424755] Starting dynamic subtest: pipe-B-plane-3
[112.650965] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[112.971357] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.508s)
[113.810716] [031/133] (908s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[113.898828] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[118.181822] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.283s)
[119.308584] [032/133] (902s left) i915_hangman (engine-error-state-capture)
[119.370526] Starting subtest: engine-error-state-capture
[119.371524] Starting dynamic subtest: rcs0
[122.877319] Dynamic subtest rcs0: SUCCESS (3.497s)
[122.886977] Starting dynamic subtest: bcs0
[128.893385] Dynamic subtest bcs0: SUCCESS (6.014s)
[128.903310] Starting dynamic subtest: vcs0
[134.846468] Dynamic subtest vcs0: SUCCESS (5.951s)
[134.853308] Starting dynamic subtest: vcs1
[139.900673] Dynamic subtest vcs1: SUCCESS (5.052s)
[139.910682] Starting dynamic subtest: vecs0
[144.893067] Dynamic subtest vecs0: SUCCESS (4.990s)
[144.900983] Starting dynamic subtest: ccs0
[150.844741] Dynamic subtest ccs0: SUCCESS (5.948s)
[150.846279] Subtest engine-error-state-capture: SUCCESS (31.464s)
[150.965473] [033/133] (871s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[151.058065] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[152.148671] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.090s)
[152.265278] [034/133] (869s left) sw_sync (sync_multi_consumer_producer)
[152.297823] Starting subtest: sync_multi_consumer_producer
[152.577132] Subtest sync_multi_consumer_producer: SUCCESS (0.270s)
[152.622897] [035/133] (869s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[152.704603] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[152.705538] Starting dynamic subtest: pipe-A-eDP-1
[158.567676] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.862s)
[158.578797] Starting dynamic subtest: pipe-B-eDP-1
[165.218962] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.650s)
[165.220039] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.514s)
[166.086620] [036/133] (856s left) kms_vblank (query-idle-hang)
[166.189329] Starting subtest: query-idle-hang
[166.190364] Starting dynamic subtest: pipe-A-eDP-1
[192.724612] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.532s)
[192.732863] Starting dynamic subtest: pipe-D-eDP-1
[207.638428] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.910s)
[207.639243] Subtest query-idle-hang: SUCCESS (41.447s)
[208.449402] [037/133] (813s left) gem_ctx_exec (basic)
[208.506841] Starting subtest: basic
[208.511277] Subtest basic: SUCCESS (0.006s)
[208.631754] [038/133] (813s left) kms_content_protection (type1)
[208.774498] Starting subtest: type1
[208.776364] Subtest type1: SKIP (0.000s)
[208.891961] [039/133] (813s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[208.980276] Starting subtest: pr-primary-plane-update-sf-dmg-area
[208.981972] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[209.044764] [040/133] (813s left) vgem_basic (bad-handle)
[209.125893] Starting subtest: bad-handle
[209.126794] Subtest bad-handle: SUCCESS (0.000s)
[209.178981] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[209.180786] [041/133] (813s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[209.301783] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[210.264797] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.962s)
[211.071571] [042/133] (811s left) gem_exec_params (invalid-fence-in-submit)
[211.131274] Starting subtest: invalid-fence-in-submit
[211.135528] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[211.254393] [043/133] (811s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[211.342596] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[218.349706] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.007s)
[218.490472] [044/133] (804s left) kms_big_fb (linear-32bpp-rotate-180)
[218.578532] Starting subtest: linear-32bpp-rotate-180
[220.168049] Subtest linear-32bpp-rotate-180: SUCCESS (1.590s)
[220.295160] [045/133] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[220.386251] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[220.387867] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[220.477975] [046/133] (802s left) gem_render_copy (x-tiled)
[220.549436] Starting subtest: x-tiled
[220.550521] Starting dynamic subtest: smem
[220.596703] Dynamic subtest smem: SUCCESS (0.046s)
[220.598211] Subtest x-tiled: SUCCESS (0.047s)
[220.810095] [047/133] (801s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[220.858905] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[220.930651] [048/133] (801s left) gem_exec_schedule (promotion)
[220.981680] Starting subtest: promotion
[220.982864] Starting dynamic subtest: rcs0
[221.091739] Dynamic subtest rcs0: SUCCESS (0.109s)
[221.101524] Starting dynamic subtest: vcs0
[221.187751] Dynamic subtest vcs0: SUCCESS (0.095s)
[221.197837] Starting dynamic subtest: vcs1
[221.279034] Dynamic subtest vcs1: SUCCESS (0.091s)
[221.289274] Starting dynamic subtest: vecs0
[221.364551] Dynamic subtest vecs0: SUCCESS (0.084s)
[221.379344] Starting dynamic subtest: ccs0
[221.466220] Dynamic subtest ccs0: SUCCESS (0.101s)
[221.467320] Subtest promotion: SUCCESS (0.485s)
[223.024034] [049/133] (799s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[223.144693] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[227.219894] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.075s)
[228.350896] [050/133] (794s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[228.405786] Starting subtest: wait-all-for-submit-delayed-submit
[228.508686] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[228.593785] [051/133] (794s left) kms_atomic_interruptible (atomic-setmode)
[228.688650] Starting subtest: atomic-setmode
[228.689610] Starting dynamic subtest: pipe-A-eDP-1
[235.613040] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.923s)
[235.613876] Subtest atomic-setmode: SUCCESS (6.925s)
[236.503316] [052/133] (786s left) kms_flip (flip-vs-expired-vblank-interruptible)
[236.595089] Starting subtest: flip-vs-expired-vblank-interruptible
[236.596282] Starting dynamic subtest: A-eDP1
[245.327060] Dynamic subtest A-eDP1: SUCCESS (8.703s)
[245.336702] Starting dynamic subtest: B-eDP1
[253.933900] Dynamic subtest B-eDP1: SUCCESS (8.602s)
[253.946087] Starting dynamic subtest: C-eDP1
[262.560359] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[262.567652] Starting dynamic subtest: D-eDP1
[271.195353] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[271.196618] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.567s)
[272.318244] [053/133] (750s left) i915_pm_rpm (system-suspend)
[274.040681] Starting subtest: system-suspend
[292.545631] Subtest system-suspend: SUCCESS (3.288s)
[297.973842] [054/133] (729s left) kms_pm_rpm (pm-tiling)
[300.324005] Starting subtest: pm-tiling
[300.326316] Subtest pm-tiling: SKIP (0.000s)
[300.682037] [055/133] (727s left) kms_psr (psr-cursor-mmap-cpu)
[300.763565] Starting subtest: psr-cursor-mmap-cpu
[300.764432] Starting dynamic subtest: eDP-1
[302.433995] Dynamic subtest eDP-1: SUCCESS (1.709s)
[302.434757] Subtest psr-cursor-mmap-cpu: SUCCESS (1.710s)
[303.275913] [056/133] (724s left) syncobj_wait (signal)
[303.333874] Starting subtest: signal
[303.334867] Subtest signal: SUCCESS (0.000s)
[303.439156] [057/133] (724s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[303.530321] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[303.532018] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[303.623792] [058/133] (724s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[303.714561] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[303.716315] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[303.820961] [059/133] (724s left) kms_atomic (plane-immutable-zpos)
[303.902630] Starting subtest: plane-immutable-zpos
[303.903566] Starting dynamic subtest: pipe-A-eDP-1
[304.535820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[304.536623] Subtest plane-immutable-zpos: SUCCESS (0.644s)
[305.376121] [060/133] (722s left) gem_ctx_persistence (engines-hang)
[305.439749] Starting subtest: engines-hang
[305.440768] Starting dynamic subtest: rcs0
[305.556611] Dynamic subtest rcs0: SUCCESS (0.119s)
[305.569766] Starting dynamic subtest: bcs0
[305.656302] Dynamic subtest bcs0: SUCCESS (0.099s)
[305.669729] Starting dynamic subtest: vcs0
[305.754643] Dynamic subtest vcs0: SUCCESS (0.097s)
[305.765762] Starting dynamic subtest: vcs1
[305.846587] Dynamic subtest vcs1: SUCCESS (0.090s)
[305.858149] Starting dynamic subtest: vecs0
[305.944523] Dynamic subtest vecs0: SUCCESS (0.097s)
[305.956712] Starting dynamic subtest: ccs0
[306.033234] Dynamic subtest ccs0: SUCCESS (0.088s)
[306.036025] Subtest engines-hang: SUCCESS (0.605s)
[306.125231] [061/133] (722s left) syncobj_timeline (signal)
[306.183769] Starting subtest: signal
[306.184793] Subtest signal: SUCCESS (0.000s)
[306.289953] [062/133] (721s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[306.403837] Starting subtest: cursor-vs-flip-varying-size
[337.699726] Subtest cursor-vs-flip-varying-size: SUCCESS (31.387s)
[338.496350] [063/133] (689s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[338.550096] Starting subtest: etime-multi-wait-available-unsubmitted
[338.667361] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[338.756513] [064/133] (689s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[338.850015] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[338.852008] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[338.930827] [065/133] (689s left) i915_drm_fdinfo (most-busy-idle-check-all)
[338.966412] Starting subtest: most-busy-idle-check-all
[338.967595] Starting dynamic subtest: rcs0
[338.974998] Dynamic subtest rcs0: SKIP (0.007s)
[338.983125] Starting dynamic subtest: bcs0
[338.984818] Dynamic subtest bcs0: SKIP (0.000s)
[338.992207] Starting dynamic subtest: vcs0
[338.993867] Dynamic subtest vcs0: SKIP (0.000s)
[339.004318] Starting dynamic subtest: vcs1
[339.006176] Dynamic subtest vcs1: SKIP (0.000s)
[339.013843] Starting dynamic subtest: vecs0
[339.015635] Dynamic subtest vecs0: SKIP (0.000s)
[339.023330] Starting dynamic subtest: ccs0
[339.024996] Dynamic subtest ccs0: SKIP (0.000s)
[339.026780] Subtest most-busy-idle-check-all: SKIP (0.014s)
[339.058697] [066/133] (689s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[339.147037] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[339.197231] [067/133] (689s left) kms_cursor_crc (cursor-offscreen-512x170)
[339.483245] Starting subtest: cursor-offscreen-512x170
[339.484999] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[339.626655] [068/133] (688s left) gem_exec_whisper (basic-fds-priority)
[339.678683] Starting subtest: basic-fds-priority
[363.651782] Subtest basic-fds-priority: SUCCESS (23.972s)
[363.846207] [069/133] (664s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[363.940947] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[363.941731] Starting dynamic subtest: pipe-A-eDP-1
[381.027693] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[381.043749] Starting dynamic subtest: pipe-B-eDP-1
[399.024384] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.760s)
[399.032549] Starting dynamic subtest: pipe-C-eDP-1
[416.978662] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.728s)
[416.986939] Starting dynamic subtest: pipe-D-eDP-1
[435.013358] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[435.014213] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.785s)
[442.252416] [070/133] (592s left) perf_pmu (busy)
[442.295315] Starting subtest: busy
[442.296277] Starting dynamic subtest: rcs0
[442.889141] Dynamic subtest rcs0: SUCCESS (0.614s)
[442.900734] Starting dynamic subtest: bcs0
[443.454235] Dynamic subtest bcs0: SUCCESS (0.581s)
[443.465889] Starting dynamic subtest: vcs0
[445.392027] Dynamic subtest vcs0: SUCCESS (1.979s)
[445.402677] Starting dynamic subtest: vcs1
[447.440513] Dynamic subtest vcs1: SUCCESS (2.088s)
[447.451316] Starting dynamic subtest: vecs0
[449.424308] Dynamic subtest vecs0: SUCCESS (2.013s)
[449.435468] Starting dynamic subtest: ccs0
[449.979778] Dynamic subtest ccs0: SUCCESS (0.570s)
[449.981244] Subtest busy: SUCCESS (7.859s)
[450.068227] [071/133] (584s left) gem_pxp (regular-baseline-src-copy-readible)
[450.189071] Starting subtest: regular-baseline-src-copy-readible
[450.252731] Subtest regular-baseline-src-copy-readible: SUCCESS (0.065s)
[450.357666] [072/133] (584s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[450.458496] Starting subtest: 4-tiled-8bpp-rotate-180
[451.658810] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.214s)
[451.751553] [073/133] (582s left) gen7_exec_parse (chained-batch)
[451.809009] Subtest chained-batch: SKIP (0.000s)
[451.876904] [074/133] (582s left) prime_self_import (basic-llseek-bad)
[451.910132] Starting subtest: basic-llseek-bad
[451.927248] Subtest basic-llseek-bad: SUCCESS (0.017s)
[452.057671] [075/133] (582s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[452.148141] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[452.149899] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[452.248104] [076/133] (582s left) api_intel_allocator (two-level-inception-interruptible)
[452.301332] Starting subtest: two-level-inception-interruptible
[457.714018] Subtest two-level-inception-interruptible: SUCCESS (5.407s)
[457.788025] [077/133] (576s left) kms_lease (lease-unleased-crtc)
[457.878368] Starting subtest: lease-unleased-crtc
[457.879266] Starting dynamic subtest: pipe-A-eDP-1
[458.167425] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[458.176833] Starting dynamic subtest: pipe-B-eDP-1
[458.927013] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[458.938149] Starting dynamic subtest: pipe-C-eDP-1
[458.939075] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[458.947113] Starting dynamic subtest: pipe-D-eDP-1
[458.948025] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[458.948931] Subtest lease-unleased-crtc: SUCCESS (1.060s)
[459.291530] [078/133] (575s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[459.384418] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[459.386311] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[459.492471] [079/133] (575s left) prime_vgem (basic-fence-mmap)
[459.566856] Starting subtest: basic-fence-mmap
[459.568632] Subtest basic-fence-mmap: SKIP (0.000s)
[459.683253] [080/133] (575s left) sw_sync (timeline_closed_signaled)
[459.718161] Starting subtest: timeline_closed_signaled
[459.718998] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[459.777893] [081/133] (575s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[459.869097] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[459.870035] Starting dynamic subtest: pipe-A-eDP-1
[459.878413] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[459.887357] Starting dynamic subtest: pipe-B-eDP-1
[459.895647] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[459.904352] Starting dynamic subtest: pipe-C-eDP-1
[459.912553] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[459.920542] Starting dynamic subtest: pipe-D-eDP-1
[459.928497] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[459.930006] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[462.144855] [082/133] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[462.234932] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[462.236520] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[462.330196] [083/133] (572s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[462.418700] Starting subtest: fbcpsr-rgb565-draw-render
[469.516476] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.115s)
[469.647606] [084/133] (565s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[469.732812] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[469.734566] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[469.804223] [085/133] (565s left) i915_suspend (basic-s2idle-without-i915)
[469.832483] Starting subtest: basic-s2idle-without-i915
[491.363885] Subtest basic-s2idle-without-i915: SUCCESS (6.020s)
[497.504756] [086/133] (543s left) gem_basic (create-fd-close)
[497.565406] Starting subtest: create-fd-close
[497.567100] Subtest create-fd-close: SUCCESS (0.000s)
[497.653471] [087/133] (543s left) api_intel_bb (object-reloc-purge-cache)
[497.706852] Starting subtest: object-reloc-purge-cache
[497.715008] Subtest object-reloc-purge-cache: SKIP (0.008s)
[497.828034] [088/133] (543s left) kms_flip (dpms-vs-vblank-race)
[497.925468] Starting subtest: dpms-vs-vblank-race
[497.927618] Starting dynamic subtest: A-eDP1
[502.837185] Dynamic subtest A-eDP1: SUCCESS (5.026s)
[502.848411] Starting dynamic subtest: B-eDP1
[507.423307] Dynamic subtest B-eDP1: SUCCESS (4.643s)
[507.434335] Starting dynamic subtest: C-eDP1
[512.024362] Dynamic subtest C-eDP1: SUCCESS (4.632s)
[512.035808] Starting dynamic subtest: D-eDP1
[516.627128] Dynamic subtest D-eDP1: SUCCESS (4.618s)
[516.628005] Subtest dpms-vs-vblank-race: SUCCESS (18.930s)
[517.510139] [089/133] (523s left) gem_userptr_blits (unsync-unmap)
[517.575967] Subtest unsync-unmap: SKIP (0.000s)
[517.699474] [090/133] (523s left) syncobj_wait (reset-during-wait-for-submit)
[517.755138] Starting subtest: reset-during-wait-for-submit
[517.858075] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[517.941746] [091/133] (523s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[518.033553] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[518.035339] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[518.131421] [092/133] (523s left) syncobj_eventfd (binary-wait-signaled)
[518.190021] Starting subtest: binary-wait-signaled
[518.191350] Subtest binary-wait-signaled: SUCCESS (0.000s)
[518.277799] [093/133] (523s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[518.363707] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[518.375157] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[518.447902] [094/133] (522s left) gem_lmem_swapping (verify-ccs)
[518.484147] Subtest verify-ccs: SKIP (0.000s)
[518.518896] [095/133] (522s left) gem_ctx_param (invalid-size-get)
[518.564217] Starting subtest: invalid-size-get
[518.565257] Subtest invalid-size-get: SUCCESS (0.001s)
[518.683451] [096/133] (522s left) gem_softpin (allocator-basic)
[518.742876] Starting subtest: allocator-basic
[518.816811] Subtest allocator-basic: SUCCESS (0.074s)
[518.934123] [097/133] (522s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[519.020949] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[519.021852] Starting dynamic subtest: pipe-A-eDP-1
[519.293557] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.263s)
[519.301620] Starting dynamic subtest: pipe-B-eDP-1
[520.574107] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.281s)
[520.582526] Starting dynamic subtest: pipe-C-eDP-1
[521.834697] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.262s)
[521.842559] Starting dynamic subtest: pipe-D-eDP-1
[523.072563] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[523.073400] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.051s)
[524.210605] [098/133] (517s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[524.296409] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[530.910117] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.616s)
[531.035965] [099/133] (510s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[531.123095] Starting subtest: random-ccs-data-yf-tiled-ccs
[531.124079] Starting dynamic subtest: pipe-A-eDP-1
[531.133357] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[531.141278] Starting dynamic subtest: pipe-B-eDP-1
[531.150317] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[531.157853] Starting dynamic subtest: pipe-C-eDP-1
[531.166853] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[531.174017] Starting dynamic subtest: pipe-D-eDP-1
[531.182898] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[531.184565] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[533.400447] [100/133] (508s left) kms_3d (basic)
[533.455323] Starting subtest: basic
[535.537789] Subtest basic: SUCCESS (2.083s)
[536.014898] [101/133] (505s left) kms_color (ctm-red-to-blue)
[536.100024] Starting subtest: ctm-red-to-blue
[536.100903] Starting dynamic subtest: pipe-A-eDP-1
[536.810142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[536.818164] Starting dynamic subtest: pipe-B-eDP-1
[538.245533] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[538.253317] Starting dynamic subtest: pipe-C-eDP-1
[539.567862] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.322s)
[539.575505] Starting dynamic subtest: pipe-D-eDP-1
[540.954998] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.386s)
[540.955939] Subtest ctm-red-to-blue: SUCCESS (4.856s)
[541.849173] [102/133] (499s left) gem_exec_fence (syncobj-channel)
[542.314726] Starting subtest: syncobj-channel
[543.340010] Subtest syncobj-channel: SUCCESS (1.016s)
[544.049594] [103/133] (497s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[544.146785] Starting subtest: extended-pageflip-modeset-hang-oldfb
[544.147609] Starting dynamic subtest: pipe-A
[552.055857] Dynamic subtest pipe-A: SUCCESS (7.909s)
[552.069578] Starting dynamic subtest: pipe-D
[560.709643] Dynamic subtest pipe-D: SUCCESS (8.654s)
[560.710645] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.568s)
[561.526046] [104/133] (480s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[561.617413] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[561.619122] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[561.714440] [105/133] (480s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[561.816467] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[561.818182] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[561.922230] [106/133] (479s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[562.008506] Starting subtest: fbc-rgb101010-draw-pwrite
[567.407878] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.402s)
[568.521695] [107/133] (473s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[568.620443] Starting subtest: fbc-psr2-cursor-plane-onoff
[568.621391] Starting dynamic subtest: eDP-1
[568.623604] Dynamic subtest eDP-1: SKIP (0.000s)
[568.625903] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[568.692394] [108/133] (473s left) kms_psr (pr-primary-page-flip)
[568.774141] Starting subtest: pr-primary-page-flip
[568.775891] Subtest pr-primary-page-flip: SKIP (0.000s)
[568.840665] [109/133] (473s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[568.953334] Starting subtest: cursor-vs-flip-legacy
[598.872217] Subtest cursor-vs-flip-legacy: SUCCESS (29.923s)
[599.703384] [110/133] (442s left) perf (stress-open-close)
[599.834544] Starting subtest: stress-open-close
[599.835336] Starting dynamic subtest: 0-rcs0
[602.002964] Dynamic subtest 0-rcs0: SUCCESS (2.168s)
[602.019357] Starting dynamic subtest: 1-vcs0
[604.171572] Dynamic subtest 1-vcs0: SUCCESS (2.167s)
[604.172550] Subtest stress-open-close: SUCCESS (4.337s)
[604.215387] [111/133] (437s left) syncobj_wait (single-wait-all-signaled)
[604.271054] Starting subtest: single-wait-all-signaled
[604.272243] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[604.394267] [112/133] (437s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[604.481420] Starting subtest: primary-4-tiled-reflect-x-0
[611.392498] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.911s)
[612.613061] [113/133] (429s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[612.706677] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[612.708669] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[612.819227] [114/133] (429s left) kms_plane_multiple (tiling-yf)
[612.903449] Starting subtest: tiling-yf
[612.905405] Subtest tiling-yf: SKIP (0.000s)
[612.973572] [115/133] (429s left) kms_addfb_basic (clobberred-modifier)
[613.020264] Starting subtest: clobberred-modifier
[613.022149] Subtest clobberred-modifier: SKIP (0.000s)
[613.157723] [116/133] (429s left) gem_exec_whisper (basic-queues-priority)
[613.219461] Starting subtest: basic-queues-priority
[636.234300] Subtest basic-queues-priority: SUCCESS (23.003s)
[636.406098] [117/133] (405s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[636.503721] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[636.504589] Starting dynamic subtest: pipe-A
[636.526322] Dynamic subtest pipe-A: SKIP (0.021s)
[636.534480] Starting dynamic subtest: pipe-B
[636.558355] Dynamic subtest pipe-B: SKIP (0.032s)
[636.566626] Starting dynamic subtest: pipe-C
[636.591727] Dynamic subtest pipe-C: SKIP (0.032s)
[636.599967] Starting dynamic subtest: pipe-D
[636.624032] Dynamic subtest pipe-D: SKIP (0.032s)
[636.625621] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.120s)
[636.731050] [118/133] (405s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[636.823104] Starting subtest: fbcpsr-2p-rte
[636.824753] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[636.907851] [119/133] (405s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[636.990005] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[636.991605] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[637.091297] [120/133] (405s left) gem_exec_fence (basic-wait)
[637.275433] Starting subtest: basic-wait
[637.276650] Starting dynamic subtest: rcs0
[637.356526] Dynamic subtest rcs0: SUCCESS (0.087s)
[637.368738] Starting dynamic subtest: bcs0
[637.415105] Dynamic subtest bcs0: SUCCESS (0.057s)
[637.427346] Starting dynamic subtest: vcs0
[637.469946] Dynamic subtest vcs0: SUCCESS (0.053s)
[637.482810] Starting dynamic subtest: vcs1
[637.532020] Dynamic subtest vcs1: SUCCESS (0.060s)
[637.543920] Starting dynamic subtest: vecs0
[637.594644] Dynamic subtest vecs0: SUCCESS (0.060s)
[637.605257] Starting dynamic subtest: ccs0
[637.659480] Dynamic subtest ccs0: SUCCESS (0.062s)
[637.662870] Subtest basic-wait: SUCCESS (0.393s)
[639.046911] [121/133] (403s left) kms_invalid_mode (bad-vsync-end)
[639.140045] Starting subtest: bad-vsync-end
[639.141430] Starting dynamic subtest: pipe-A-eDP-1
[639.430768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[639.439436] Starting dynamic subtest: pipe-B-eDP-1
[639.440318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[639.448087] Starting dynamic subtest: pipe-C-eDP-1
[639.448906] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[639.456849] Starting dynamic subtest: pipe-D-eDP-1
[639.457721] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[639.458627] Subtest bad-vsync-end: SUCCESS (0.293s)
[640.215664] [122/133] (402s left) gem_ccs (ctrl-surf-copy-new-ctx)
[640.265863] Starting subtest: ctrl-surf-copy-new-ctx
[640.268346] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[640.368698] [123/133] (402s left) gem_exec_fence (basic-wait-all)
[640.435191] Starting subtest: basic-wait-all
[640.526694] Subtest basic-wait-all: SUCCESS (0.091s)
[642.041791] [124/133] (400s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[642.170453] Starting subtest: flip-vs-cursor-legacy
[649.769938] Subtest flip-vs-cursor-legacy: SUCCESS (7.599s)
[650.607705] [125/133] (391s left) kms_prop_blob (blob-prop-lifetime)
[650.657799] Starting subtest: blob-prop-lifetime
[650.658719] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[650.772561] [126/133] (391s left) gen7_exec_parse (basic-allocation)
[650.834496] Subtest basic-allocation: SKIP (0.000s)
[650.906236] [127/133] (391s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[651.297079] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[652.076644] [128/133] (390s left) kms_pm_dc (dc9-dpms)
[653.175781] Starting subtest: dc9-dpms
[654.588546] Subtest dc9-dpms: SUCCESS (1.415s)
[654.656842] [129/133] (388s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[654.703831] Starting subtest: multi-wait-available-submitted-signaled
[654.704793] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[654.815292] [130/133] (387s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[654.886025] Starting subtest: y-tiled-ccs-to-x-tiled
[654.888100] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[655.074454] [131/133] (387s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[655.170496] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[678.175649] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.011s)
[678.295568] [132/133] (364s left) syncobj_timeline (invalid-signal-illegal-handle)
[678.363371] Starting subtest: invalid-signal-illegal-handle
[678.364330] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[678.463503] [133/133] (364s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[678.545678] Starting subtest: stress-xrgb8888-xtiled
[684.379575] Subtest stress-xrgb8888-xtiled: SUCCESS (5.836s)
[684.425144] Closing watchdogs
results: parsing output: 0/ for test: kms_setmode
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_nop
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: gen3_render_tiledx_blits
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: dumb_buffer
results: parsing output: 19/ for test: kms_selftest
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_dither
results: parsing output: 22/ for test: gem_ctx_engines
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: gem_tiled_pread_pwrite
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: i915_hangman
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: sw_sync
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: gem_ctx_exec
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: gem_fenced_exec_thrash
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_atomic_interruptible
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: i915_pm_rpm
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_atomic
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: kms_pipe_b_c_ivb
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: gem_exec_whisper
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: gem_pxp
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gen7_exec_parse
results: parsing output: 73/ for test: prime_self_import
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: api_intel_allocator
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: prime_vgem
results: parsing output: 79/ for test: sw_sync
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: i915_suspend
results: parsing output: 85/ for test: gem_basic
results: parsing output: 86/ for test: api_intel_bb
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_eventfd
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: gem_ctx_param
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_3d
results: parsing output: 100/ for test: kms_color
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: kms_busy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_plane_multiple
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: kms_invalid_mode
results: parsing output: 121/ for test: gem_ccs
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: kms_prop_blob
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: kms_pm_dc
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_pipe_stress
Done.