[58.015494] Initializing watchdogs
[58.015544]   /dev/watchdog0
[58.034388] [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]
[58.039017] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.041457] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.044959] [001/133] (960s left) perf_pmu (render-node-busy)
[58.151218] Starting subtest: render-node-busy
[58.153544] Starting dynamic subtest: rcs0
[58.746817] Dynamic subtest rcs0: SUCCESS (0.595s)
[58.757844] Starting dynamic subtest: bcs0
[59.303613] Dynamic subtest bcs0: SUCCESS (0.556s)
[59.312325] Starting dynamic subtest: vcs0
[61.317624] Dynamic subtest vcs0: SUCCESS (2.011s)
[61.326942] Starting dynamic subtest: vcs1
[63.302585] Dynamic subtest vcs1: SUCCESS (1.984s)
[63.312715] Starting dynamic subtest: vecs0
[65.285314] Dynamic subtest vecs0: SUCCESS (1.981s)
[65.297322] Starting dynamic subtest: ccs0
[65.849678] Dynamic subtest ccs0: SUCCESS (0.565s)
[65.852574] Subtest render-node-busy: SUCCESS (7.699s)
[65.935631] [002/133] (952s left) gem_exec_schedule (fifo)
[66.009328] Starting subtest: fifo
[66.011726] Starting dynamic subtest: rcs0
[66.175080] Dynamic subtest rcs0: SUCCESS (0.174s)
[66.183922] Starting dynamic subtest: vcs0
[66.272412] Dynamic subtest vcs0: SUCCESS (0.097s)
[66.286544] Starting dynamic subtest: vcs1
[66.373338] Dynamic subtest vcs1: SUCCESS (0.102s)
[66.384817] Starting dynamic subtest: vecs0
[66.479992] Dynamic subtest vecs0: SUCCESS (0.106s)
[66.492660] Starting dynamic subtest: ccs0
[66.601293] Dynamic subtest ccs0: SUCCESS (0.121s)
[66.603705] Subtest fifo: SUCCESS (0.602s)
[67.428388] [003/133] (951s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[67.533626] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[67.537763] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[67.621075] [004/133] (951s left) gem_pxp (create-regular-context-1)
[67.740316] Starting subtest: create-regular-context-1
[67.742763] Subtest create-regular-context-1: SUCCESS (0.002s)
[67.858306] [005/133] (950s left) gem_madvise (dontneed-before-mmap)
[67.892787] Starting subtest: dontneed-before-mmap
[67.910822] Subtest dontneed-before-mmap: SUCCESS (0.017s)
[68.020086] [006/133] (950s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[68.127292] Starting subtest: x-tiled-32bpp-rotate-90
[68.165321] Subtest x-tiled-32bpp-rotate-90: SKIP (0.035s)
[68.271402] [007/133] (950s left) gem_workarounds (suspend-resume-context)
[68.344062] Starting subtest: suspend-resume-context
[84.703174] Subtest suspend-resume-context: SUCCESS (1.286s)
[84.830045] [008/133] (933s left) kms_psr (fbc-psr2-cursor-plane-move)
[84.931700] Starting subtest: fbc-psr2-cursor-plane-move
[84.934006] Starting dynamic subtest: eDP-1
[84.938502] Dynamic subtest eDP-1: SKIP (0.000s)
[84.942855] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[85.000989] [009/133] (933s left) kms_big_fb (linear-16bpp-rotate-0)
[85.107595] Starting subtest: linear-16bpp-rotate-0
[86.554810] Subtest linear-16bpp-rotate-0: SUCCESS (1.446s)
[86.676010] [010/133] (932s left) gem_lmem_swapping (heavy-verify-multi)
[86.720881] Subtest heavy-verify-multi: SKIP (0.000s)
[86.758997] [011/133] (932s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[86.847787] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[86.849819] Starting dynamic subtest: pipe-A-default-mode
[88.035956] Dynamic subtest pipe-A-default-mode: SKIP (1.185s)
[88.040888] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.186s)
[88.282681] [012/133] (930s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[88.390779] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[88.393537] Starting dynamic subtest: pipe-A-eDP-1
[88.417509] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[88.427976] Starting dynamic subtest: pipe-B-eDP-1
[88.450910] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[88.460439] Starting dynamic subtest: pipe-C-eDP-1
[88.482611] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[88.492063] Starting dynamic subtest: pipe-D-eDP-1
[88.514513] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[88.518544] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[90.667321] [013/133] (928s left) perf (polling)
[90.797508] Starting subtest: polling
[90.799422] Starting dynamic subtest: 0-rcs0
[100.824815] Dynamic subtest 0-rcs0: SUCCESS (10.024s)
[100.835038] Starting dynamic subtest: 1-vecs0
[110.845443] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[110.847977] Subtest polling: SUCCESS (20.045s)
[110.893173] [014/133] (908s left) gem_userptr_blits (readonly-unsync)
[110.966512] Subtest readonly-unsync: SKIP (0.000s)
[111.102443] [015/133] (907s left) kms_psr (pr-primary-render)
[111.194964] Starting subtest: pr-primary-render
[111.199267] Subtest pr-primary-render: SKIP (0.000s)
[111.268939] [016/133] (907s left) kms_frontbuffer_tracking (fbc-tiling-4)
[111.377904] Starting subtest: fbc-tiling-4
[115.592606] Subtest fbc-tiling-4: SUCCESS (4.218s)
[116.765118] [017/133] (902s left) syncobj_timeline (single-wait-available-submitted)
[116.822203] Starting subtest: single-wait-available-submitted
[116.824426] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[116.916118] [018/133] (902s left) perf_pmu (busy-check-all)
[116.955856] Starting subtest: busy-check-all
[116.958260] Starting dynamic subtest: rcs0
[117.515176] Dynamic subtest rcs0: SUCCESS (0.559s)
[117.527333] Starting dynamic subtest: bcs0
[118.065646] Dynamic subtest bcs0: SUCCESS (0.550s)
[118.078303] Starting dynamic subtest: vcs0
[119.401046] Dynamic subtest vcs0: SUCCESS (1.333s)
[119.414003] Starting dynamic subtest: vcs1
[121.384961] Dynamic subtest vcs1: SUCCESS (1.983s)
[121.397427] Starting dynamic subtest: vecs0
[123.368738] Dynamic subtest vecs0: SUCCESS (1.983s)
[123.380921] Starting dynamic subtest: ccs0
[123.923145] Dynamic subtest ccs0: SUCCESS (0.555s)
[123.925777] Subtest busy-check-all: SUCCESS (6.969s)
[124.015341] [019/133] (895s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[124.135413] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[124.140184] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[124.278852] [020/133] (895s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[124.376959] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[124.380969] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[124.441239] [021/133] (894s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[124.556381] Starting subtest: 2x-long-cursor-vs-flip-atomic
[124.561009] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[124.710178] [022/133] (894s left) prime_busy (after)
[124.767289] Starting subtest: after
[124.771752] Starting dynamic subtest: rcs0
[124.808861] Dynamic subtest rcs0: SUCCESS (0.038s)
[124.822051] Starting dynamic subtest: bcs0
[124.867162] Dynamic subtest bcs0: SUCCESS (0.058s)
[124.877317] Starting dynamic subtest: vcs0
[124.905596] Dynamic subtest vcs0: SUCCESS (0.039s)
[124.914734] Starting dynamic subtest: vcs1
[124.946460] Dynamic subtest vcs1: SUCCESS (0.040s)
[124.957467] Starting dynamic subtest: vecs0
[124.985505] Dynamic subtest vecs0: SUCCESS (0.039s)
[124.995796] Starting dynamic subtest: ccs0
[125.026206] Dynamic subtest ccs0: SUCCESS (0.040s)
[125.135057] Subtest after: SUCCESS (0.366s)
[125.211144] [023/133] (894s left) gem_exec_fence (basic-busy-all)
[125.276447] Starting subtest: basic-busy-all
[125.367970] Subtest basic-busy-all: SUCCESS (0.092s)
[127.484827] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[127.488320] [024/133] (891s left) drm_read (short-buffer-wakeup)
[127.656568] Starting subtest: short-buffer-wakeup
[159.868307] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[160.028076] [025/133] (859s left) gem_exec_reloc (basic-write-read-noreloc)
[160.097343] Subtest basic-write-read-noreloc: SKIP (0.000s)
[160.170629] [026/133] (859s left) i915_pm_rps (thresholds-idle)
[160.223865] Starting subtest: thresholds-idle
[160.228319] Subtest thresholds-idle: SKIP (0.000s)
[160.331511] [027/133] (859s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[160.417565] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[160.419982] Starting dynamic subtest: pipe-A
[160.529937] Dynamic subtest pipe-A: SKIP (0.108s)
[160.542988] Starting dynamic subtest: pipe-B
[161.725773] Dynamic subtest pipe-B: SKIP (1.194s)
[161.737029] Starting dynamic subtest: pipe-C
[162.940695] Dynamic subtest pipe-C: SUCCESS (1.221s)
[162.952753] Starting dynamic subtest: pipe-D
[164.099017] Dynamic subtest pipe-D: SUCCESS (1.157s)
[164.101581] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.683s)
[165.300908] [028/133] (854s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[165.407828] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[165.420290] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[165.532793] [029/133] (854s left) gem_exec_balancer (hang)
[165.804139] Starting subtest: hang
[167.499312] Subtest hang: SUCCESS (1.699s)
[167.640419] [030/133] (852s left) kms_pm_dc (dc5-dpms-negative)
[168.740220] Starting subtest: dc5-dpms-negative
[168.744399] Subtest dc5-dpms-negative: SKIP (0.000s)
[168.828901] [031/133] (850s left) gem_exec_schedule (preempt-contexts)
[168.903481] Starting subtest: preempt-contexts
[168.905717] Starting dynamic subtest: rcs0
[168.959093] Dynamic subtest rcs0: SUCCESS (0.063s)
[168.972228] Starting dynamic subtest: bcs0
[169.012994] Dynamic subtest bcs0: SUCCESS (0.054s)
[169.024920] Starting dynamic subtest: vcs0
[169.062648] Dynamic subtest vcs0: SUCCESS (0.049s)
[169.073757] Starting dynamic subtest: vcs1
[169.106478] Dynamic subtest vcs1: SUCCESS (0.043s)
[169.116603] Starting dynamic subtest: vecs0
[169.149851] Dynamic subtest vecs0: SUCCESS (0.043s)
[169.160935] Starting dynamic subtest: ccs0
[169.196286] Dynamic subtest ccs0: SUCCESS (0.046s)
[169.198579] Subtest preempt-contexts: SUCCESS (0.301s)
[170.505140] [032/133] (849s left) kms_pm_backlight (bad-brightness)
[170.603297] Starting subtest: bad-brightness
[170.651905] Starting dynamic subtest: eDP-1
[170.960930] Dynamic subtest eDP-1: SUCCESS (0.308s)
[170.963372] Subtest bad-brightness: SUCCESS (0.359s)
[171.820746] [033/133] (848s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[171.909527] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[171.911881] Starting dynamic subtest: pipe-A-eDP-1
[172.207034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.265s)
[172.218604] Starting dynamic subtest: pipe-B-eDP-1
[173.501300] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.291s)
[173.513495] Starting dynamic subtest: pipe-C-eDP-1
[174.715206] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s)
[174.726102] Starting dynamic subtest: pipe-D-eDP-1
[175.964988] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[175.967065] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.027s)
[177.176981] [034/133] (842s left) kms_chamelium_audio (dp-audio-edid)
[177.569165] Subtest dp-audio-edid: SKIP (0.000s)
[178.364879] [035/133] (841s left) kms_selftest (drm_cmdline_parser)
[178.401599] Starting subtest: drm_cmdline_parser
[178.415190] Starting dynamic subtest: drm_test_cmdline_force_d_only
[178.498924] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.082s)
[178.510512] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[178.582894] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.085s)
[178.594918] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[178.673286] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.090s)
[178.682979] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[178.758490] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.085s)
[178.769089] Starting dynamic subtest: drm_test_cmdline_force_e_only
[178.847353] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.087s)
[178.857067] Starting dynamic subtest: drm_test_cmdline_res
[178.931909] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.084s)
[178.941947] Starting dynamic subtest: drm_test_cmdline_res_vesa
[179.012370] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.080s)
[179.021936] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[179.123704] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.112s)
[179.133862] Starting dynamic subtest: drm_test_cmdline_res_rblank
[179.212297] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.088s)
[179.222338] Starting dynamic subtest: drm_test_cmdline_res_bpp
[179.296159] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.084s)
[179.306048] Starting dynamic subtest: drm_test_cmdline_res_refresh
[179.381760] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.086s)
[179.391165] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[179.472289] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.089s)
[179.484061] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[179.565261] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.093s)
[179.574664] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[179.653277] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.087s)
[179.662444] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[179.736597] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.084s)
[179.745926] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[179.825431] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.088s)
[179.835222] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[179.913460] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.086s)
[179.922855] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[180.009631] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.096s)
[180.018769] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[180.088053] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.078s)
[180.099336] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[180.165702] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.077s)
[180.175111] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[180.248324] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.082s)
[180.259341] Starting dynamic subtest: drm_test_cmdline_name
[180.331406] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.083s)
[180.341762] Starting dynamic subtest: drm_test_cmdline_name_bpp
[180.415693] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.083s)
[180.424886] Starting dynamic subtest: drm_test_cmdline_name_option
[180.504744] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.089s)
[180.515262] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[180.591487] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.086s)
[180.600511] Starting dynamic subtest: drm_test_cmdline_rotate_0
[180.687727] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.095s)
[180.696760] Starting dynamic subtest: drm_test_cmdline_rotate_90
[180.771857] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.084s)
[180.781315] Starting dynamic subtest: drm_test_cmdline_rotate_180
[180.857689] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.084s)
[180.867307] Starting dynamic subtest: drm_test_cmdline_rotate_270
[180.939960] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.082s)
[180.949309] Starting dynamic subtest: drm_test_cmdline_hmirror
[181.029608] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.089s)
[181.039104] Starting dynamic subtest: drm_test_cmdline_vmirror
[181.150308] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.118s)
[181.160050] Starting dynamic subtest: drm_test_cmdline_margin_options
[181.247205] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.098s)
[181.256880] Starting dynamic subtest: drm_test_cmdline_multiple_options
[181.339879] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.091s)
[181.350550] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[181.440505] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.100s)
[181.450520] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[181.530929] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.089s)
[181.541165] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[181.622582] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.091s)
[181.631886] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[181.718432] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.095s)
[181.727879] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[181.818292] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.100s)
[181.827561] Starting dynamic subtest: drm_test_cmdline_invalid
[181.919542] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.100s)
[181.929400] Starting dynamic subtest: drm_test_cmdline_tv_options
[182.012208] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.094s)
[182.014404] Subtest drm_cmdline_parser: SUCCESS (3.613s)
[182.174160] [036/133] (837s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[182.283300] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[182.287009] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[182.379818] [037/133] (837s left) kms_atomic_transition (modeset-transition)
[182.471516] Starting subtest: modeset-transition
[182.473307] Starting dynamic subtest: 1x-outputs
[193.351050] Dynamic subtest 1x-outputs: SUCCESS (10.879s)
[193.353320] Subtest modeset-transition: SUCCESS (10.880s)
[194.208371] [038/133] (825s left) kms_frontbuffer_tracking (psr-1p-rte)
[194.304378] Starting subtest: psr-1p-rte
[199.696378] Subtest psr-1p-rte: SUCCESS (5.396s)
[199.836068] [039/133] (820s left) gem_exec_fence (long-history)
[200.248083] Starting subtest: long-history
[207.154490] Subtest long-history: SUCCESS (6.907s)
[207.615925] [040/133] (812s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[207.716606] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[207.721012] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[207.810750] [041/133] (812s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[207.906526] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[207.910836] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[208.010810] [042/133] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[208.108903] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[208.113037] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[208.208757] [043/133] (812s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[208.261029] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[208.364619] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[208.454590] [044/133] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[208.547717] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[208.551915] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[208.637446] [045/133] (811s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[208.734167] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[215.656174] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.925s)
[215.782467] [046/133] (804s left) sysfs_heartbeat_interval (precise)
[215.843737] Starting subtest: precise
[215.846105] Starting dynamic subtest: vecs0
[223.398454] Dynamic subtest vecs0: SUCCESS (7.554s)
[223.413338] Starting dynamic subtest: ccs0
[224.611090] Dynamic subtest ccs0: SUCCESS (1.210s)
[224.622013] Starting dynamic subtest: vcs0
[232.358922] Dynamic subtest vcs0: SUCCESS (7.746s)
[232.372142] Starting dynamic subtest: bcs0
[233.453215] Dynamic subtest bcs0: SUCCESS (1.090s)
[233.465965] Starting dynamic subtest: rcs0
[234.531779] Dynamic subtest rcs0: SUCCESS (1.080s)
[234.543021] Starting dynamic subtest: vcs1
[242.336600] Dynamic subtest vcs1: SUCCESS (7.801s)
[242.339285] Subtest precise: SUCCESS (26.490s)
[242.426963] [047/133] (778s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[242.537262] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[242.541509] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[242.631720] [048/133] (777s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[242.718098] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[242.720824] Starting dynamic subtest: pipe-A-eDP-1
[242.744082] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[242.755305] Starting dynamic subtest: pipe-B-eDP-1
[242.776453] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.787215] Starting dynamic subtest: pipe-C-eDP-1
[242.808393] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.817804] Starting dynamic subtest: pipe-D-eDP-1
[242.839508] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.843893] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[244.965447] [049/133] (775s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[245.024971] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[245.027323] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[245.158290] [050/133] (775s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[245.249852] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[245.254000] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[245.361554] [051/133] (775s left) i915_drm_fdinfo (most-busy-idle-check-all)
[245.400892] Starting subtest: most-busy-idle-check-all
[245.403082] Starting dynamic subtest: rcs0
[245.407746] Dynamic subtest rcs0: SKIP (0.004s)
[245.419207] Starting dynamic subtest: bcs0
[245.423571] Dynamic subtest bcs0: SKIP (0.000s)
[245.433344] Starting dynamic subtest: vcs0
[245.437816] Dynamic subtest vcs0: SKIP (0.000s)
[245.448321] Starting dynamic subtest: vcs1
[245.452587] Dynamic subtest vcs1: SKIP (0.000s)
[245.462329] Starting dynamic subtest: vecs0
[245.466708] Dynamic subtest vecs0: SKIP (0.000s)
[245.478988] Starting dynamic subtest: ccs0
[245.483216] Dynamic subtest ccs0: SKIP (0.000s)
[245.487403] Subtest most-busy-idle-check-all: SKIP (0.008s)
[245.525807] [052/133] (775s left) kms_lease (lease-invalid-connector)
[245.655522] Starting subtest: lease-invalid-connector
[245.657869] Starting dynamic subtest: pipe-A-eDP-1
[245.660107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[245.671286] Starting dynamic subtest: pipe-B-eDP-1
[245.673212] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[245.684624] Starting dynamic subtest: pipe-C-eDP-1
[245.686892] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[245.696736] Starting dynamic subtest: pipe-D-eDP-1
[245.698968] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[245.701222] Subtest lease-invalid-connector: SUCCESS (0.003s)
[245.741826] [053/133] (774s left) gen9_exec_parse (bb-start-out)
[245.794549] Subtest bb-start-out: SKIP (0.000s)
[245.875275] [054/133] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[245.974185] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[250.354925] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.385s)
[251.570253] [055/133] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[251.667744] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[251.672107] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[251.768991] [056/133] (769s left) kms_psr (psr2-cursor-mmap-gtt)
[251.865579] Starting subtest: psr2-cursor-mmap-gtt
[251.867968] Starting dynamic subtest: eDP-1
[253.548139] Dynamic subtest eDP-1: SUCCESS (1.683s)
[253.550583] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.683s)
[254.422369] [057/133] (766s left) gem_softpin (allocator-fork)
[254.484036] Starting subtest: allocator-fork
[256.699931] Subtest allocator-fork: SUCCESS (2.214s)
[256.844151] [058/133] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[256.951738] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[260.665317] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.717s)
[261.824954] [059/133] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[261.923690] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[261.927976] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[262.018908] [060/133] (758s left) gem_eio (banned)
[262.226319] Starting subtest: banned
[262.814562] Subtest banned: SUCCESS (0.588s)
[262.974798] [061/133] (758s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[263.023568] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[263.131728] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s)
[263.226343] [062/133] (757s left) kms_flip (modeset-vs-vblank-race)
[263.316454] Starting subtest: modeset-vs-vblank-race
[263.318345] Starting dynamic subtest: A-eDP1
[268.060094] Dynamic subtest A-eDP1: SUCCESS (4.745s)
[268.078370] Starting dynamic subtest: B-eDP1
[272.801463] Dynamic subtest B-eDP1: SUCCESS (4.738s)
[272.815091] Starting dynamic subtest: C-eDP1
[277.511452] Dynamic subtest C-eDP1: SUCCESS (4.707s)
[277.526951] Starting dynamic subtest: D-eDP1
[282.075141] Dynamic subtest D-eDP1: SUCCESS (4.561s)
[282.077556] Subtest modeset-vs-vblank-race: SUCCESS (18.765s)
[283.247075] [063/133] (737s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[283.369546] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[284.317477] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.945s)
[285.165630] [064/133] (735s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[285.259497] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[285.263885] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[285.332957] [065/133] (735s left) kms_vblank (ts-continuation-modeset)
[285.424287] Starting subtest: ts-continuation-modeset
[285.426266] Starting dynamic subtest: pipe-A-eDP-1
[286.941299] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.516s)
[286.958457] Starting dynamic subtest: pipe-D-eDP-1
[289.111807] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.169s)
[289.113741] Subtest ts-continuation-modeset: SUCCESS (3.688s)
[289.922865] [066/133] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[290.019015] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[290.023486] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[290.119722] [067/133] (731s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[290.219236] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[290.223304] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[290.326249] [068/133] (731s left) kms_cursor_crc (cursor-offscreen-256x256)
[290.583763] Starting subtest: cursor-offscreen-256x256
[290.590341] Starting dynamic subtest: pipe-A-eDP-1
[292.552325] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.965s)
[292.586745] Starting dynamic subtest: pipe-D-eDP-1
[295.138316] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s)
[295.140604] Subtest cursor-offscreen-256x256: SUCCESS (4.555s)
[295.985283] [069/133] (725s left) gem_ctx_persistence (legacy-engines-persistence)
[296.067949] Starting subtest: legacy-engines-persistence
[296.070284] Starting dynamic subtest: render
[296.876221] Dynamic subtest render: SUCCESS (0.807s)
[296.889317] Starting dynamic subtest: bsd1
[297.636341] Dynamic subtest bsd1: SUCCESS (0.757s)
[297.651864] Starting dynamic subtest: bsd2
[298.397572] Dynamic subtest bsd2: SUCCESS (0.758s)
[298.410134] Starting dynamic subtest: blt
[299.168700] Dynamic subtest blt: SUCCESS (0.769s)
[299.185036] Starting dynamic subtest: vebox
[299.935017] Dynamic subtest vebox: SUCCESS (0.763s)
[299.938185] Subtest legacy-engines-persistence: SUCCESS (3.868s)
[300.022596] [070/133] (721s left) kms_addfb_basic (basic-x-tiled-legacy)
[300.084304] Starting subtest: basic-x-tiled-legacy
[300.088455] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[300.255379] [071/133] (721s left) gem_exec_flush (basic-wb-pro-default)
[300.323496] Starting subtest: basic-wb-pro-default
[305.786018] Subtest basic-wb-pro-default: SUCCESS (5.463s)
[305.971992] [072/133] (715s left) kms_hdr (invalid-metadata-sizes)
[306.071229] Starting subtest: invalid-metadata-sizes
[306.077749] Subtest invalid-metadata-sizes: SKIP (0.000s)
[306.144636] [073/133] (715s left) gem_exec_reloc (basic-write-gtt)
[306.198707] Subtest basic-write-gtt: SKIP (0.000s)
[306.271033] [074/133] (715s left) kms_frontbuffer_tracking (fbc-suspend)
[306.358803] Starting subtest: fbc-suspend
[344.186831] Subtest fbc-suspend: SUCCESS (7.499s)
[345.382419] [075/133] (676s left) kms_dsc (dsc-with-output-formats)
[345.483457] Starting subtest: dsc-with-output-formats
[345.511226] Subtest dsc-with-output-formats: SKIP (0.000s)
[345.558393] [076/133] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[345.655270] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[353.086551] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.432s)
[353.225422] [077/133] (668s left) syncobj_wait (reset-unsignaled)
[353.276906] Starting subtest: reset-unsignaled
[353.279469] Subtest reset-unsignaled: SUCCESS (0.000s)
[353.374364] [078/133] (668s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[353.421578] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[353.426898] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[353.609303] [079/133] (668s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[353.666175] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[353.669071] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[353.789159] [080/133] (668s left) gem_mmap_gtt (hang-user)
[353.845737] Subtest hang-user: SKIP (0.000s)
[353.903275] [081/133] (668s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[353.999352] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[354.002042] Starting dynamic subtest: pipe-A-default-mode
[355.153063] Dynamic subtest pipe-A-default-mode: SKIP (1.153s)
[355.158711] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.154s)
[355.316382] [082/133] (666s left) kms_content_protection (type1)
[355.465870] Starting subtest: type1
[355.470130] Subtest type1: SKIP (0.000s)
[355.578289] [083/133] (666s left) perf (invalid-create-userspace-config)
[355.666582] Starting subtest: invalid-create-userspace-config
[355.669675] Subtest invalid-create-userspace-config: SUCCESS (0.002s)
[355.712680] [084/133] (666s left) kms_invalid_mode (bad-htotal)
[355.816841] Starting subtest: bad-htotal
[355.819564] Starting dynamic subtest: pipe-A-eDP-1
[356.111890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[356.123783] Starting dynamic subtest: pipe-B-eDP-1
[356.126707] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[356.137314] Starting dynamic subtest: pipe-C-eDP-1
[356.139738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[356.149727] Starting dynamic subtest: pipe-D-eDP-1
[356.152158] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[356.154497] Subtest bad-htotal: SUCCESS (0.300s)
[356.957620] [085/133] (665s left) api_intel_bb (offset-control)
[357.014904] Starting subtest: offset-control
[357.023825] Subtest offset-control: SUCCESS (0.011s)
[357.118326] [086/133] (665s left) gem_exec_flush (basic-wb-rw-default)
[357.177830] Starting subtest: basic-wb-rw-default
[362.641927] Subtest basic-wb-rw-default: SUCCESS (5.456s)
[362.830680] [087/133] (659s left) perf (blocking)
[362.918141] Starting subtest: blocking
[362.920636] Starting dynamic subtest: 0-rcs0
[372.943802] Dynamic subtest 0-rcs0: SUCCESS (10.020s)
[372.956717] Starting dynamic subtest: 1-vcs1
[382.973716] Dynamic subtest 1-vcs1: SUCCESS (10.024s)
[382.976463] Subtest blocking: SUCCESS (20.047s)
[383.026422] [088/133] (639s left) kms_psr (fbc-pr-primary-blt)
[383.119838] Starting subtest: fbc-pr-primary-blt
[383.125362] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[383.181159] [089/133] (639s left) gem_ctx_shared (q-smoketest)
[383.251789] Starting subtest: Q-smoketest
[383.254585] Starting dynamic subtest: rcs0
[388.838923] Dynamic subtest rcs0: SUCCESS (5.530s)
[388.852116] Starting dynamic subtest: bcs0
[394.347373] Dynamic subtest bcs0: SUCCESS (5.501s)
[394.358661] Starting dynamic subtest: vcs0
[399.844492] Dynamic subtest vcs0: SUCCESS (5.496s)
[399.859433] Starting dynamic subtest: vcs1
[405.326732] Dynamic subtest vcs1: SUCCESS (5.482s)
[405.337484] Starting dynamic subtest: vecs0
[410.824918] Dynamic subtest vecs0: SUCCESS (5.491s)
[410.838218] Starting dynamic subtest: ccs0
[416.319360] Dynamic subtest ccs0: SUCCESS (5.489s)
[416.322144] Subtest Q-smoketest: SUCCESS (32.999s)
[416.455595] [090/133] (605s left) prime_vgem (basic-fence-read)
[416.527382] Starting subtest: basic-fence-read
[416.564570] Subtest basic-fence-read: SKIP (0.034s)
[416.684960] [091/133] (605s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[416.776347] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[416.778759] Starting dynamic subtest: pipe-A-eDP-1
[416.801552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[416.812947] Starting dynamic subtest: pipe-B-eDP-1
[416.836212] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[416.846350] Starting dynamic subtest: pipe-C-eDP-1
[416.869716] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[416.879894] Starting dynamic subtest: pipe-D-eDP-1
[416.903557] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[416.905915] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[419.026240] [092/133] (603s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[419.183166] Starting subtest: cursor-rapid-movement-32x32
[419.233723] Subtest cursor-rapid-movement-32x32: SKIP (0.046s)
[419.514922] [093/133] (602s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[419.617602] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[419.622623] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[419.693359] [094/133] (602s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[420.092431] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[420.939003] [095/133] (601s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[421.043928] Starting subtest: yf-tiled-32bpp-rotate-0
[421.048770] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[421.135446] [096/133] (601s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[421.230715] Starting subtest: bo-too-small-due-to-tiling
[421.235566] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[421.313520] [097/133] (601s left) kms_frontbuffer_tracking (psr-slowdraw)
[421.404157] Starting subtest: psr-slowdraw
[446.733689] Subtest psr-slowdraw: SUCCESS (25.325s)
[446.863682] [098/133] (575s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[447.251887] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[448.033070] [099/133] (574s left) kms_cursor_crc (cursor-suspend)
[448.162740] Starting subtest: cursor-suspend
[448.165687] Starting dynamic subtest: pipe-A-eDP-1
[481.161116] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.107s)
[481.172468] Starting dynamic subtest: pipe-D-eDP-1
[515.181035] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.795s)
[515.182892] Subtest cursor-suspend: SUCCESS (6.905s)
[516.007543] [100/133] (506s left) syncobj_wait (wait-any-snapshot)
[516.064061] Starting subtest: wait-any-snapshot
[516.143882] Subtest wait-any-snapshot: SUCCESS (0.081s)
[516.238192] [101/133] (506s left) gem_exec_balancer (sequential)
[516.306180] Starting subtest: sequential
[519.443560] Subtest sequential: SUCCESS (3.131s)
[519.779389] [102/133] (503s left) kms_color (degamma)
[519.878881] Starting subtest: degamma
[519.881121] Starting dynamic subtest: pipe-A-eDP-1
[520.613217] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[520.623886] Starting dynamic subtest: pipe-B-eDP-1
[522.033870] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[522.044602] Starting dynamic subtest: pipe-C-eDP-1
[523.412249] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[523.422667] Starting dynamic subtest: pipe-D-eDP-1
[524.753204] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[524.755474] Subtest degamma: SUCCESS (4.868s)
[525.554056] [103/133] (497s left) perf (invalid-oa-exponent)
[525.641816] Starting subtest: invalid-oa-exponent
[525.651253] Subtest invalid-oa-exponent: SUCCESS (0.012s)
[525.696317] [104/133] (497s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[525.791926] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[525.804912] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[525.914309] [105/133] (497s left) gem_wait (await)
[525.984489] Starting subtest: await
[525.986972] Starting dynamic subtest: all-engines
[527.106572] Dynamic subtest all-engines: SUCCESS (1.121s)
[527.126016] Starting dynamic subtest: rcs0
[528.168422] Dynamic subtest rcs0: SUCCESS (1.059s)
[528.189128] Starting dynamic subtest: bcs0
[529.229352] Dynamic subtest bcs0: SUCCESS (1.056s)
[529.248660] Starting dynamic subtest: vcs0
[530.283750] Dynamic subtest vcs0: SUCCESS (1.051s)
[530.303759] Starting dynamic subtest: vcs1
[531.337396] Dynamic subtest vcs1: SUCCESS (1.050s)
[531.355627] Starting dynamic subtest: vecs0
[532.390908] Dynamic subtest vecs0: SUCCESS (1.051s)
[532.409036] Starting dynamic subtest: ccs0
[533.448309] Dynamic subtest ccs0: SUCCESS (1.054s)
[533.450879] Subtest await: SUCCESS (7.459s)
[533.666992] [106/133] (489s left) gem_eio (in-flight-immediate)
[533.895301] Starting subtest: in-flight-immediate
[542.476572] Subtest in-flight-immediate: SUCCESS (8.576s)
[542.605306] [107/133] (480s left) i915_pm_rpm (gem-pread)
[544.137518] Starting subtest: gem-pread
[546.262669] Subtest gem-pread: SUCCESS (2.127s)
[546.399259] [108/133] (476s left) kms_plane_cursor (overlay)
[546.488683] Starting subtest: overlay
[546.492817] Starting dynamic subtest: pipe-A-eDP-1-size-64
[549.154059] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.664s)
[549.215643] Starting dynamic subtest: pipe-A-eDP-1-size-128
[551.900071] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.694s)
[551.961078] Starting dynamic subtest: pipe-A-eDP-1-size-256
[554.635676] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.682s)
[554.994338] Starting dynamic subtest: pipe-B-eDP-1-size-64
[558.446678] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.466s)
[558.511511] Starting dynamic subtest: pipe-B-eDP-1-size-128
[561.169110] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.671s)
[561.232593] Starting dynamic subtest: pipe-B-eDP-1-size-256
[563.894409] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.671s)
[564.247155] Starting dynamic subtest: pipe-C-eDP-1-size-64
[567.321353] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.084s)
[567.361532] Starting dynamic subtest: pipe-C-eDP-1-size-128
[569.722068] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.369s)
[569.761934] Starting dynamic subtest: pipe-C-eDP-1-size-256
[572.112141] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.359s)
[572.450180] Starting dynamic subtest: pipe-D-eDP-1-size-64
[575.540211] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.102s)
[575.580317] Starting dynamic subtest: pipe-D-eDP-1-size-128
[577.942141] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.370s)
[577.984781] Starting dynamic subtest: pipe-D-eDP-1-size-256
[580.321712] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.348s)
[580.639420] Subtest overlay: SUCCESS (34.133s)
[581.442096] [109/133] (441s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[581.541367] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[581.545864] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[581.667667] [110/133] (441s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[581.767460] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[581.771780] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[581.854084] [111/133] (441s left) gem_mmap_gtt (cpuset-medium-copy)
[581.908155] Subtest cpuset-medium-copy: SKIP (0.000s)
[581.963497] [112/133] (441s left) gem_pxp (protected-raw-src-copy-not-readible)
[582.060337] Starting subtest: protected-raw-src-copy-not-readible
[582.127441] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.068s)
[582.246899] [113/133] (441s left) i915_module_load (resize-bar)
[582.283696] Starting subtest: resize-bar
[582.290099] Subtest resize-bar: SKIP (0.007s)
[582.331736] [114/133] (441s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[582.388090] Starting subtest: invalid-bsd2-flag-on-vebox
[582.390022] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[582.481438] [115/133] (440s left) kms_psr (fbc-psr-primary-page-flip)
[582.564881] Starting subtest: fbc-psr-primary-page-flip
[582.566904] Starting dynamic subtest: eDP-1
[582.570530] Dynamic subtest eDP-1: SKIP (0.000s)
[582.574036] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[582.636716] [116/133] (440s left) gem_ctx_param (invalid-size-get)
[582.680004] Starting subtest: invalid-size-get
[582.681884] Subtest invalid-size-get: SUCCESS (0.001s)
[582.792596] [117/133] (440s left) kms_psr (psr-primary-page-flip)
[582.873273] Starting subtest: psr-primary-page-flip
[582.875293] Starting dynamic subtest: eDP-1
[584.655844] Dynamic subtest eDP-1: SUCCESS (1.781s)
[584.658211] Subtest psr-primary-page-flip: SUCCESS (1.782s)
[585.515744] [118/133] (438s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[585.619371] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[585.623839] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[585.717541] [119/133] (437s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[585.821153] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[585.825077] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[585.926033] [120/133] (437s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[586.029161] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[586.033653] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[586.141035] [121/133] (437s left) gem_exec_reloc (basic-cpu-read-noreloc)
[586.199597] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[586.273661] [122/133] (437s left) i915_query (query-topology-unsupported)
[586.316059] Starting subtest: query-topology-unsupported
[586.320070] Subtest query-topology-unsupported: SKIP (0.000s)
[586.408132] [123/133] (437s left) api_intel_allocator (two-level-inception-interruptible)
[586.461774] Starting subtest: two-level-inception-interruptible
[591.872442] Subtest two-level-inception-interruptible: SUCCESS (5.409s)
[592.001902] [124/133] (431s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[592.110723] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[592.136873] Starting dynamic subtest: pipe-A-plane-0
[592.425634] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[592.436885] Starting dynamic subtest: pipe-A-plane-3
[592.638406] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[593.702223] Starting dynamic subtest: pipe-B-plane-0
[593.972457] Dynamic subtest pipe-B-plane-0: SUCCESS (0.277s)
[593.983779] Starting dynamic subtest: pipe-B-plane-3
[594.205076] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[594.528214] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.416s)
[595.386838] [125/133] (428s left) kms_pm_rpm (modeset-lpsp)
[596.906192] Starting subtest: modeset-lpsp
[598.349823] Subtest modeset-lpsp: SUCCESS (1.445s)
[598.450088] [126/133] (425s left) gem_exec_whisper (basic-contexts)
[598.510173] Starting subtest: basic-contexts
[605.974661] Subtest basic-contexts: SUCCESS (7.460s)
[606.165201] [127/133] (417s left) gem_ctx_persistence (engines-hang)
[606.227698] Starting subtest: engines-hang
[606.229953] Starting dynamic subtest: rcs0
[606.313857] Dynamic subtest rcs0: SUCCESS (0.085s)
[606.327309] Starting dynamic subtest: bcs0
[606.423356] Dynamic subtest bcs0: SUCCESS (0.108s)
[606.439919] Starting dynamic subtest: vcs0
[606.521629] Dynamic subtest vcs0: SUCCESS (0.095s)
[606.535072] Starting dynamic subtest: vcs1
[606.608936] Dynamic subtest vcs1: SUCCESS (0.085s)
[606.622177] Starting dynamic subtest: vecs0
[606.703602] Dynamic subtest vecs0: SUCCESS (0.093s)
[606.716965] Starting dynamic subtest: ccs0
[606.776435] Dynamic subtest ccs0: SUCCESS (0.071s)
[606.778858] Subtest engines-hang: SUCCESS (0.550s)
[606.914456] [128/133] (417s left) syncobj_wait (single-wait-all-for-submit-submitted)
[606.963549] Starting subtest: single-wait-all-for-submit-submitted
[607.065016] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[607.145247] [129/133] (416s left) gem_exec_params (batch-first)
[607.189750] Starting subtest: batch-first
[607.196216] Subtest batch-first: SUCCESS (0.006s)
[607.322556] [130/133] (416s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[607.429480] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[608.499749] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.068s)
[608.620488] [131/133] (415s left) gem_create (create-ext-cpu-access-sanity-check)
[608.779478] Starting subtest: create-ext-cpu-access-sanity-check
[608.784425] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[608.855786] [132/133] (415s left) gem_exec_schedule (reorder-wide)
[609.029847] Subtest reorder-wide: SKIP (0.000s)
[609.211155] [133/133] (414s left) gem_ccs (ctrl-surf-copy)
[609.273505] Starting subtest: ctrl-surf-copy
[609.278076] Subtest ctrl-surf-copy: SKIP (0.000s)
[609.371765] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_pxp
results: parsing output: 4/ for test: gem_madvise
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: prime_busy
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: drm_read
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: i915_pm_rps
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_pm_dc
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_pm_backlight
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_chamelium_audio
results: parsing output: 34/ for test: kms_selftest
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_atomic_transition
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: sysfs_heartbeat_interval
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gen9_exec_parse
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_softpin
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: gem_exec_flush
results: parsing output: 71/ for test: kms_hdr
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_dsc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_content_protection
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: kms_invalid_mode
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: kms_chamelium_edid
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_color
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_wait
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: i915_pm_rpm
results: parsing output: 107/ for test: kms_plane_cursor
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: gem_pxp
results: parsing output: 112/ for test: i915_module_load
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_ctx_param
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: i915_query
results: parsing output: 122/ for test: api_intel_allocator
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_params
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_create
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: gem_ccs
Done.