[55.731502] Initializing watchdogs
[55.731593]   /dev/watchdog0
[55.746316] [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]
[55.750532] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.752792] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.756183] [001/130] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[60.840812] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[60.843282] Starting dynamic subtest: pipe-A-eDP-1
[61.622894] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s)
[61.630560] Starting dynamic subtest: pipe-B-eDP-1
[62.752625] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[62.757011] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.913s)
[63.928809] [002/130] (952s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[64.032035] Starting subtest: bad-rotation-90-yf-tiled-ccs
[64.034473] Starting dynamic subtest: pipe-A-eDP-1
[64.058063] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[64.066569] Starting dynamic subtest: pipe-B-eDP-1
[64.088347] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[64.094415] Starting dynamic subtest: pipe-C-eDP-1
[64.116264] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[64.122365] Starting dynamic subtest: pipe-D-eDP-1
[64.144702] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[64.149317] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.002s)
[66.186607] [003/130] (950s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[66.244321] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[66.246682] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[66.358469] [004/130] (950s left) gem_exec_schedule (implicit-boths)
[66.432714] Starting subtest: implicit-boths
[66.435164] Starting dynamic subtest: rcs0
[66.530941] Dynamic subtest rcs0: SUCCESS (0.106s)
[66.539963] Starting dynamic subtest: vcs0
[66.611366] Dynamic subtest vcs0: SUCCESS (0.080s)
[66.620594] Starting dynamic subtest: vcs1
[66.686770] Dynamic subtest vcs1: SUCCESS (0.076s)
[66.694902] Starting dynamic subtest: vecs0
[66.761331] Dynamic subtest vecs0: SUCCESS (0.074s)
[66.771130] Starting dynamic subtest: ccs0
[66.840649] Dynamic subtest ccs0: SUCCESS (0.079s)
[66.843076] Subtest implicit-boths: SUCCESS (0.417s)
[68.033933] [005/130] (948s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[68.149155] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[99.473556] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.324s)
[100.303177] [006/130] (916s left) gem_ctx_sseu (mmap-args)
[100.371962] Subtest mmap-args: SKIP (0.000s)
[100.452321] [007/130] (916s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[100.540848] Starting subtest: primary-yf-tiled-reflect-x-0
[100.603462] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[100.702734] [008/130] (915s left) syncobj_wait (wait-for-submit-complex)
[100.745552] Starting subtest: wait-for-submit-complex
[100.805344] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[100.877614] [009/130] (915s left) gem_flink_race (flink_close)
[100.912068] Starting subtest: flink_close
[106.018385] Subtest flink_close: SUCCESS (5.105s)
[106.089287] [010/130] (910s left) kms_invalid_mode (int-max-clock)
[106.204354] Starting subtest: int-max-clock
[106.206670] Starting dynamic subtest: pipe-A-eDP-1
[106.486455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[106.494506] Starting dynamic subtest: pipe-B-eDP-1
[106.496654] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[106.503312] Starting dynamic subtest: pipe-C-eDP-1
[106.505467] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[106.511861] Starting dynamic subtest: pipe-D-eDP-1
[106.513688] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[106.515571] Subtest int-max-clock: SUCCESS (0.287s)
[107.328892] [011/130] (909s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[107.726786] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[108.543207] [012/130] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[108.649876] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[108.654460] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[108.755417] [013/130] (907s left) perf_pmu (busy-idle-check-all)
[108.793077] Starting subtest: busy-idle-check-all
[108.794856] Starting dynamic subtest: rcs0
[109.487428] Dynamic subtest rcs0: SUCCESS (0.695s)
[109.497696] Starting dynamic subtest: bcs0
[110.138516] Dynamic subtest bcs0: SUCCESS (0.651s)
[110.148793] Starting dynamic subtest: vcs0
[111.890458] Dynamic subtest vcs0: SUCCESS (1.750s)
[111.900153] Starting dynamic subtest: vcs1
[113.939252] Dynamic subtest vcs1: SUCCESS (2.049s)
[113.948347] Starting dynamic subtest: vecs0
[115.922700] Dynamic subtest vecs0: SUCCESS (1.983s)
[115.932603] Starting dynamic subtest: ccs0
[116.579610] Dynamic subtest ccs0: SUCCESS (0.658s)
[116.582119] Subtest busy-idle-check-all: SUCCESS (7.788s)
[116.675306] [014/130] (900s left) kms_selftest (drm_cmdline_parser)
[116.714085] Starting subtest: drm_cmdline_parser
[116.731257] Starting dynamic subtest: drm_test_cmdline_force_d_only
[116.872033] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.140s)
[116.878925] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[117.002072] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.129s)
[117.009158] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[117.126060] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.123s)
[117.134845] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[117.253506] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.127s)
[117.262127] Starting dynamic subtest: drm_test_cmdline_force_e_only
[117.380399] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.126s)
[117.389239] Starting dynamic subtest: drm_test_cmdline_res
[117.462472] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.082s)
[117.471264] Starting dynamic subtest: drm_test_cmdline_res_vesa
[117.597203] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.134s)
[117.606424] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[117.692444] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.096s)
[117.700800] Starting dynamic subtest: drm_test_cmdline_res_rblank
[117.804631] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.111s)
[117.812978] Starting dynamic subtest: drm_test_cmdline_res_bpp
[117.927385] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.123s)
[117.935913] Starting dynamic subtest: drm_test_cmdline_res_refresh
[118.078399] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.151s)
[118.087496] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[118.189300] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.112s)
[118.198406] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[118.293252] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.104s)
[118.302220] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[118.414310] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.120s)
[118.423092] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[118.515313] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.102s)
[118.524076] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[118.631274] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.115s)
[118.640435] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[118.749297] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.118s)
[118.758546] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[118.868092] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.118s)
[118.875416] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[118.992860] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.125s)
[118.999859] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[119.107366] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.115s)
[119.116791] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[119.225934] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.117s)
[119.233205] Starting dynamic subtest: drm_test_cmdline_name
[119.361996] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.136s)
[119.369731] Starting dynamic subtest: drm_test_cmdline_name_bpp
[119.476619] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.115s)
[119.484400] Starting dynamic subtest: drm_test_cmdline_name_option
[119.604391] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.126s)
[119.612123] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[119.725555] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.121s)
[119.733041] Starting dynamic subtest: drm_test_cmdline_rotate_0
[119.868943] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.144s)
[119.876317] Starting dynamic subtest: drm_test_cmdline_rotate_90
[119.970426] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.102s)
[119.977679] Starting dynamic subtest: drm_test_cmdline_rotate_180
[120.049171] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.079s)
[120.057848] Starting dynamic subtest: drm_test_cmdline_rotate_270
[120.158739] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.109s)
[120.171692] Starting dynamic subtest: drm_test_cmdline_hmirror
[120.286466] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.126s)
[120.295622] Starting dynamic subtest: drm_test_cmdline_vmirror
[120.388530] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.102s)
[120.398081] Starting dynamic subtest: drm_test_cmdline_margin_options
[120.490668] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.102s)
[120.499546] Starting dynamic subtest: drm_test_cmdline_multiple_options
[120.615107] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.124s)
[120.622877] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[120.730337] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.115s)
[120.738264] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[120.858065] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.128s)
[120.864846] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[120.996326] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.138s)
[121.005446] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[121.121088] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.125s)
[121.129933] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[121.241158] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.120s)
[121.249077] Starting dynamic subtest: drm_test_cmdline_invalid
[121.362490] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.122s)
[121.371482] Starting dynamic subtest: drm_test_cmdline_tv_options
[121.480146] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.118s)
[121.481998] Subtest drm_cmdline_parser: SUCCESS (4.764s)
[121.659439] [015/130] (895s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[121.725035] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[121.729438] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[121.903144] [016/130] (894s left) kms_dsc (dsc-with-bpc)
[121.993163] Starting subtest: dsc-with-bpc
[122.025390] Subtest dsc-with-bpc: SKIP (0.001s)
[122.065069] [017/130] (894s left) prime_busy (hang-wait)
[122.134253] Starting subtest: hang-wait
[122.136559] Starting dynamic subtest: rcs0
[149.358599] Dynamic subtest rcs0: SUCCESS (27.221s)
[149.365843] Starting dynamic subtest: bcs0
[156.516633] Dynamic subtest bcs0: SUCCESS (7.158s)
[156.526071] Starting dynamic subtest: vcs0
[163.491355] Dynamic subtest vcs0: SUCCESS (6.973s)
[163.500483] Starting dynamic subtest: vcs1
[170.526224] Dynamic subtest vcs1: SUCCESS (7.036s)
[170.533238] Starting dynamic subtest: vecs0
[177.565388] Dynamic subtest vecs0: SUCCESS (7.038s)
[177.572628] Starting dynamic subtest: ccs0
[191.403619] Dynamic subtest ccs0: SUCCESS (13.837s)
[191.406842] Subtest hang-wait: SUCCESS (69.266s)
[191.564481] [018/130] (825s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[191.676309] Starting subtest: y-tiled-32bpp-rotate-180
[191.680292] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[191.756891] [019/130] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[191.857657] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[191.861986] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[191.950696] [020/130] (825s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[192.334640] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[193.150891] [021/130] (823s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[195.094435] Starting subtest: modeset-non-lpsp-stress-no-wait
[195.159634] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.063s)
[195.467219] [022/130] (821s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[195.566073] Starting subtest: nonblocking-crc-frame-sequence
[195.568421] Starting dynamic subtest: pipe-A-eDP-1
[196.348577] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.782s)
[196.357387] Starting dynamic subtest: pipe-B-eDP-1
[197.764857] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s)
[197.773663] Starting dynamic subtest: pipe-C-eDP-1
[199.156984] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[199.165873] Starting dynamic subtest: pipe-D-eDP-1
[200.481992] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[200.484295] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.913s)
[201.264393] [023/130] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[201.368956] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[201.372981] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[201.451161] [024/130] (815s left) perf (enable-disable)
[201.569418] Starting subtest: enable-disable
[201.571644] Starting dynamic subtest: 0-rcs0
[203.849635] Dynamic subtest 0-rcs0: SUCCESS (2.280s)
[203.857297] Starting dynamic subtest: 1-vcs0
[208.358845] Dynamic subtest 1-vcs0: SUCCESS (4.510s)
[208.361324] Subtest enable-disable: SUCCESS (6.791s)
[208.403683] [025/130] (808s left) gem_mmap_wc (bad-object)
[208.459415] Subtest bad-object: SKIP (0.000s)
[208.521599] [026/130] (808s left) vgem_basic (sysfs)
[208.602193] Starting subtest: sysfs
[208.604427] Subtest sysfs: SUCCESS (0.000s)
[208.653271] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[208.656564] [027/130] (808s left) gem_ctx_shared (q-smoketest)
[208.721993] Starting subtest: Q-smoketest
[208.725307] Starting dynamic subtest: rcs0
[214.292245] Dynamic subtest rcs0: SUCCESS (5.525s)
[214.300308] Starting dynamic subtest: bcs0
[219.820221] Dynamic subtest bcs0: SUCCESS (5.524s)
[219.832895] Starting dynamic subtest: vcs0
[225.296054] Dynamic subtest vcs0: SUCCESS (5.480s)
[225.304703] Starting dynamic subtest: vcs1
[230.770124] Dynamic subtest vcs1: SUCCESS (5.472s)
[230.778063] Starting dynamic subtest: vecs0
[236.257421] Dynamic subtest vecs0: SUCCESS (5.483s)
[236.265919] Starting dynamic subtest: ccs0
[241.771550] Dynamic subtest ccs0: SUCCESS (5.513s)
[241.773669] Subtest Q-smoketest: SUCCESS (32.999s)
[241.904904] [028/130] (775s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[242.030157] Starting subtest: basic-flip-before-cursor-varying-size
[242.977602] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.948s)
[243.792077] [029/130] (773s left) gem_mmap (bad-size)
[243.850486] Subtest bad-size: SKIP (0.000s)
[243.908570] [030/130] (773s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[244.011824] Starting subtest: invalid-modeset-force-ultra-joiner
[244.016474] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[244.076105] [031/130] (773s left) gen3_mixed_blits
[244.210060] [032/130] (773s left) kms_setmode (invalid-clone-single-crtc-stealing)
[244.269068] Starting subtest: invalid-clone-single-crtc-stealing
[244.275872] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[244.368681] [033/130] (773s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[244.474585] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[244.479093] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[244.582433] [034/130] (772s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[244.685493] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[244.689582] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[244.794286] [035/130] (772s left) kms_psr (fbc-psr-sprite-plane-onoff)
[244.889149] Starting subtest: fbc-psr-sprite-plane-onoff
[244.891114] Starting dynamic subtest: eDP-1
[244.894629] Dynamic subtest eDP-1: SKIP (0.000s)
[244.898176] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[244.958860] [036/130] (772s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[245.061537] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[251.751241] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.691s)
[251.897727] [037/130] (765s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[252.009374] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[252.013438] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[252.123615] [038/130] (765s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[252.229451] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[258.616370] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.386s)
[258.729235] [039/130] (758s left) kms_hdmi_inject (inject-audio)
[259.072230] Starting subtest: inject-audio
[259.342368] Subtest inject-audio: SUCCESS (0.273s)
[259.943331] [040/130] (757s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[260.033131] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[260.035518] Starting dynamic subtest: pipe-A-eDP-1
[260.058784] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[260.069353] Starting dynamic subtest: pipe-B-eDP-1
[260.091343] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[260.098877] Starting dynamic subtest: pipe-C-eDP-1
[260.120681] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[260.127954] Starting dynamic subtest: pipe-D-eDP-1
[260.149771] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[260.154110] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[262.307797] [041/130] (755s left) kms_chamelium_color (ctm-0-25)
[262.404373] Subtest ctm-0-25: SKIP (0.000s)
[262.457846] [042/130] (755s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[262.557571] Starting subtest: 4-tiled-16bpp-rotate-270
[262.577352] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[262.700924] [043/130] (755s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[262.768790] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[262.771121] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[262.876529] [044/130] (755s left) i915_pm_rc6_residency (media-rc6-accuracy)
[262.924489] Starting subtest: media-rc6-accuracy
[262.928766] Subtest media-rc6-accuracy: SKIP (0.000s)
[263.039401] [045/130] (754s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[263.145368] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[264.390878] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.245s)
[264.577861] [046/130] (753s left) i915_pm_rps (fence-order)
[264.636931] Starting subtest: fence-order
[267.518050] Subtest fence-order: SUCCESS (2.880s)
[267.605835] [047/130] (750s left) kms_vrr (flipline)
[267.704159] Starting subtest: flipline
[267.710959] Subtest flipline: SKIP (0.000s)
[267.776925] [048/130] (750s left) drm_read (short-buffer-block)
[267.939197] Starting subtest: short-buffer-block
[267.941516] Subtest short-buffer-block: SUCCESS (0.000s)
[268.076871] [049/130] (750s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[268.139675] Starting subtest: basic-batch-kernel-default-cmd
[268.144078] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[268.320328] [050/130] (749s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[268.414725] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[268.425720] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[268.534155] [051/130] (749s left) gem_reg_read (timestamp-moving)
[268.587995] Starting subtest: timestamp-moving
[269.588383] Subtest timestamp-moving: SUCCESS (1.001s)
[269.661815] [052/130] (748s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[269.760869] Starting subtest: psr-rgb565-draw-mmap-wc
[276.462534] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.704s)
[276.596349] [053/130] (741s left) gem_request_retire (retire-vma-not-inactive)
[276.667758] Starting subtest: retire-vma-not-inactive
[276.728483] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[276.862925] [054/130] (741s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[276.959306] Starting subtest: plane-all-modeset-transition-fencing
[276.963719] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[277.029625] [055/130] (741s left) gem_userptr_blits (vma-merge)
[277.098212] Starting subtest: vma-merge
[277.139733] Subtest vma-merge: SUCCESS (0.041s)
[277.254018] [056/130] (741s left) gen7_exec_parse (bitmasks)
[277.304368] Subtest bitmasks: SKIP (0.000s)
[277.378394] [057/130] (741s left) kms_psr (fbc-psr2-cursor-blt)
[277.471431] Starting subtest: fbc-psr2-cursor-blt
[277.473251] Starting dynamic subtest: eDP-1
[277.476852] Dynamic subtest eDP-1: SKIP (0.000s)
[277.480499] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[277.541963] [058/130] (740s left) kms_force_connector_basic (prune-stale-modes)
[277.614962] Starting subtest: prune-stale-modes
[278.018079] Subtest prune-stale-modes: SUCCESS (0.403s)
[278.157062] [059/130] (740s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[278.250549] Starting subtest: 2x-flip-vs-rmfb-interruptible
[278.263641] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[278.335856] [060/130] (740s left) kms_content_protection (uevent)
[278.509512] Starting subtest: uevent
[281.858591] Subtest uevent: SKIP (3.346s)
[283.002849] [061/130] (735s left) kms_universal_plane (universal-plane-pageflip-windowed)
[283.105089] Starting subtest: universal-plane-pageflip-windowed
[283.107385] Starting dynamic subtest: pipe-A-eDP-1
[283.723666] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s)
[283.731667] Starting dynamic subtest: pipe-B-eDP-1
[284.900663] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.175s)
[284.909643] Starting dynamic subtest: pipe-C-eDP-1
[286.087876] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[286.097172] Starting dynamic subtest: pipe-D-eDP-1
[287.286597] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s)
[287.288954] Subtest universal-plane-pageflip-windowed: SUCCESS (4.181s)
[288.105976] [062/130] (730s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[288.207700] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[288.212160] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[288.294307] [063/130] (730s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[288.387196] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[288.389558] Starting dynamic subtest: pipe-A
[288.398890] Dynamic subtest pipe-A: SKIP (0.004s)
[288.408516] Starting dynamic subtest: pipe-B
[288.418103] Dynamic subtest pipe-B: SKIP (0.018s)
[288.428176] Starting dynamic subtest: pipe-C
[288.437209] Dynamic subtest pipe-C: SKIP (0.019s)
[288.447709] Starting dynamic subtest: pipe-D
[288.456715] Dynamic subtest pipe-D: SKIP (0.020s)
[288.460940] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.063s)
[288.570364] [064/130] (730s left) kms_pm_rpm (drm-resources-equal)
[290.109716] Starting subtest: drm-resources-equal
[295.407359] Subtest drm-resources-equal: SUCCESS (5.298s)
[295.494981] [065/130] (723s left) kms_draw_crc (draw-method-blt)
[295.594333] Starting subtest: draw-method-blt
[295.596578] Starting dynamic subtest: xrgb8888-untiled
[295.843974] Dynamic subtest xrgb8888-untiled: SUCCESS (0.252s)
[295.852065] Starting dynamic subtest: rgb565-untiled
[296.078094] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[296.085785] Starting dynamic subtest: xrgb2101010-untiled
[296.288451] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[296.296342] Starting dynamic subtest: xbgr16161616f-untiled
[296.521533] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[296.529746] Starting dynamic subtest: xrgb8888-xtiled
[296.632844] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[296.643536] Starting dynamic subtest: rgb565-xtiled
[296.743883] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[296.752314] Starting dynamic subtest: xrgb2101010-xtiled
[296.832243] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.088s)
[296.842201] Starting dynamic subtest: xbgr16161616f-xtiled
[296.943537] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[296.951888] Starting dynamic subtest: xrgb8888-4tiled
[297.065935] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[297.073946] Starting dynamic subtest: rgb565-4tiled
[297.176899] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[297.184905] Starting dynamic subtest: xrgb2101010-4tiled
[297.276876] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[297.284871] Starting dynamic subtest: xbgr16161616f-4tiled
[297.388162] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s)
[297.390109] Subtest draw-method-blt: SUCCESS (1.797s)
[297.513230] [066/130] (721s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[297.575721] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[297.577716] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[297.684087] [067/130] (721s left) syncobj_eventfd (invalid-bad-pad)
[297.742896] Starting subtest: invalid-bad-pad
[297.744826] Subtest invalid-bad-pad: SUCCESS (0.000s)
[297.857472] [068/130] (721s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[297.962439] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[305.268366] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.306s)
[305.447606] [069/130] (713s left) kms_pm_backlight (fade-with-suspend)
[305.544240] Starting subtest: fade-with-suspend
[321.862590] Starting dynamic subtest: eDP-1
[324.529198] Dynamic subtest eDP-1: SUCCESS (2.669s)
[324.531553] Subtest fade-with-suspend: SUCCESS (4.410s)
[331.416945] [070/130] (693s left) gem_exec_params (invalid-fence-in)
[331.484897] Starting subtest: invalid-fence-in
[331.487333] Subtest invalid-fence-in: SUCCESS (0.000s)
[331.592994] [071/130] (693s left) kms_async_flips (alternate-sync-async-flip-atomic)
[331.691576] Starting subtest: alternate-sync-async-flip-atomic
[332.075187] Starting dynamic subtest: pipe-A-eDP-1
[334.869432] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.793s)
[335.251390] Starting dynamic subtest: pipe-B-eDP-1
[338.068753] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.826s)
[338.449953] Starting dynamic subtest: pipe-C-eDP-1
[341.271814] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.829s)
[341.633189] Starting dynamic subtest: pipe-D-eDP-1
[344.375216] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.748s)
[344.377218] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.677s)
[345.510938] [072/130] (679s left) gem_ctx_freq (sysfs)
[345.570625] Starting subtest: sysfs
[345.572762] Starting dynamic subtest: gt0
[351.111141] Dynamic subtest gt0: SUCCESS (5.538s)
[351.125975] Starting dynamic subtest: gt1
[392.514457] Dynamic subtest gt1: SUCCESS (41.392s)
[392.517012] Subtest sysfs: SUCCESS (46.935s)
[392.593175] [073/130] (632s left) kms_cursor_crc (cursor-random-32x32)
[392.749171] Starting subtest: cursor-random-32x32
[392.791766] Subtest cursor-random-32x32: SKIP (0.038s)
[393.076759] [074/130] (632s left) kms_cursor_crc (cursor-sliding-128x128)
[393.294762] Starting subtest: cursor-sliding-128x128
[393.297047] Starting dynamic subtest: pipe-A-eDP-1
[396.992375] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.696s)
[397.020150] Starting dynamic subtest: pipe-D-eDP-1
[401.315169] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.300s)
[401.317515] Subtest cursor-sliding-128x128: SUCCESS (8.020s)
[402.111791] [075/130] (623s left) gem_exec_whisper (basic-forked)
[402.174546] Starting subtest: basic-forked
[408.980237] Subtest basic-forked: SUCCESS (6.801s)
[409.166836] [076/130] (616s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[409.223576] Starting subtest: wait-all-for-submit-delayed-submit
[409.329263] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[409.407444] [077/130] (615s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[409.513058] Starting subtest: fbc-tiling-linear
[413.216567] Subtest fbc-tiling-linear: SUCCESS (3.708s)
[414.329226] [078/130] (610s left) gem_pxp (create-valid-protected-context)
[414.452474] Starting subtest: create-valid-protected-context
[414.455086] Subtest create-valid-protected-context: SUCCESS (0.002s)
[414.556059] [079/130] (610s left) gem_busy (busy)
[414.613529] Starting subtest: busy
[414.615899] Starting dynamic subtest: all-engines
[414.679821] Dynamic subtest all-engines: SUCCESS (0.066s)
[414.689894] Starting dynamic subtest: rcs0
[416.460103] Dynamic subtest rcs0: SUCCESS (1.777s)
[416.470033] Starting dynamic subtest: bcs0
[416.540028] Dynamic subtest bcs0: SUCCESS (0.077s)
[416.550117] Starting dynamic subtest: vcs0
[416.578154] Dynamic subtest vcs0: SUCCESS (0.038s)
[416.586754] Starting dynamic subtest: vcs1
[418.503256] Dynamic subtest vcs1: SUCCESS (1.922s)
[418.512120] Starting dynamic subtest: vecs0
[420.490238] Dynamic subtest vecs0: SUCCESS (1.984s)
[420.501037] Starting dynamic subtest: ccs0
[422.472806] Dynamic subtest ccs0: SUCCESS (1.983s)
[422.474964] Subtest busy: SUCCESS (7.855s)
[422.832382] [080/130] (602s left) kms_big_fb (linear-64bpp-rotate-270)
[422.933872] Starting subtest: linear-64bpp-rotate-270
[422.952823] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[423.091512] [081/130] (602s left) kms_addfb_basic (tile-pitch-mismatch)
[423.140187] Starting subtest: tile-pitch-mismatch
[423.145052] Subtest tile-pitch-mismatch: SKIP (0.000s)
[423.297565] [082/130] (602s left) gem_exec_reloc (basic-write-read-noreloc)
[423.357701] Subtest basic-write-read-noreloc: SKIP (0.000s)
[423.440255] [083/130] (602s left) gem_exec_balancer (parallel-out-fence)
[423.686907] Starting subtest: parallel-out-fence
[424.760210] Subtest parallel-out-fence: SUCCESS (1.072s)
[424.878270] [084/130] (600s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[424.976444] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[424.978875] Starting dynamic subtest: pipe-A-default-mode
[426.139292] Dynamic subtest pipe-A-default-mode: SKIP (1.158s)
[426.143631] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.160s)
[426.293268] [085/130] (599s left) api_intel_bb (reset-bb)
[426.357381] Starting subtest: reset-bb
[426.363259] Subtest reset-bb: SUCCESS (0.004s)
[426.491585] [086/130] (599s left) api_intel_bb (bb-with-allocator)
[426.551404] Starting subtest: bb-with-allocator
[426.553993] Subtest bb-with-allocator: SUCCESS (0.006s)
[426.697043] [087/130] (598s left) gem_userptr_blits (sync-unmap-after-close)
[426.756408] Starting subtest: sync-unmap-after-close
[426.769345] Subtest sync-unmap-after-close: SUCCESS (0.013s)
[426.909496] [088/130] (598s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[427.000835] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[427.003148] Starting dynamic subtest: pipe-A-eDP-1
[427.063211] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[427.071488] Starting dynamic subtest: pipe-B-eDP-1
[427.119662] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[427.130015] Starting dynamic subtest: pipe-C-eDP-1
[427.176855] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[427.186350] Starting dynamic subtest: pipe-D-eDP-1
[427.234583] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[427.238113] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[429.217628] [089/130] (596s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[429.321459] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[429.325653] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[429.435786] [090/130] (596s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[429.542333] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[433.225405] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.689s)
[434.431495] [091/130] (591s left) kms_cursor_edge_walk (256x256-top-edge)
[434.530859] Starting subtest: 256x256-top-edge
[434.533219] Starting dynamic subtest: pipe-A-eDP-1
[437.943862] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s)
[437.953745] Starting dynamic subtest: pipe-D-eDP-1
[441.136232] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.191s)
[441.138676] Subtest 256x256-top-edge: SUCCESS (6.606s)
[442.005647] [092/130] (583s left) syncobj_wait (wait-any-complex)
[442.067032] Starting subtest: wait-any-complex
[442.126170] Subtest wait-any-complex: SUCCESS (0.062s)
[442.206703] [093/130] (583s left) perf_pmu (init-sema)
[442.244531] Starting subtest: init-sema
[442.246868] Starting dynamic subtest: rcs0
[442.249234] Dynamic subtest rcs0: SUCCESS (0.001s)
[442.259154] Starting dynamic subtest: bcs0
[442.261116] Dynamic subtest bcs0: SUCCESS (0.000s)
[442.269636] Starting dynamic subtest: vcs0
[442.271577] Dynamic subtest vcs0: SUCCESS (0.001s)
[442.279930] Starting dynamic subtest: vcs1
[442.281835] Dynamic subtest vcs1: SUCCESS (0.001s)
[442.290427] Starting dynamic subtest: vecs0
[442.292636] Dynamic subtest vecs0: SUCCESS (0.000s)
[442.301154] Starting dynamic subtest: ccs0
[442.303088] Dynamic subtest ccs0: SUCCESS (0.000s)
[442.305021] Subtest init-sema: SUCCESS (0.006s)
[442.345294] [094/130] (583s left) syncobj_wait (multi-wait-all-signaled)
[442.395348] Starting subtest: multi-wait-all-signaled
[442.397714] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[442.508643] [095/130] (583s left) kms_psr (psr-cursor-plane-onoff)
[442.604708] Starting subtest: psr-cursor-plane-onoff
[442.606973] Starting dynamic subtest: eDP-1
[444.365194] Dynamic subtest eDP-1: SUCCESS (1.762s)
[444.367743] Subtest psr-cursor-plane-onoff: SUCCESS (1.763s)
[445.205964] [096/130] (580s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[450.298773] Starting subtest: pr-cursor-plane-update-sf
[450.303577] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[451.111416] [097/130] (574s left) gem_exec_fence (syncobj-timeline-unused-fence)
[451.673388] Starting subtest: syncobj-timeline-unused-fence
[451.680091] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[453.605831] [098/130] (572s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[453.706575] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[453.710695] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[453.801287] [099/130] (572s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[453.903845] Starting subtest: yf-tiled-16bpp-rotate-180
[453.908359] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[454.009742] [100/130] (572s left) gem_mmap_wc (read-write-distinct)
[454.069355] Subtest read-write-distinct: SKIP (0.000s)
[454.140947] [101/130] (572s left) gem_lmem_swapping (heavy-verify-random)
[454.183832] Subtest heavy-verify-random: SKIP (0.000s)
[454.230694] [102/130] (572s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[454.328797] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[454.333433] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[455.412111] [103/130] (570s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[455.503908] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[455.506297] Starting dynamic subtest: pipe-A-default-mode
[455.793283] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[455.798035] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.287s)
[456.603934] [104/130] (569s left) i915_selftest (mock)
[460.120038] Starting subtest: mock
[460.122179] Starting dynamic subtest: sanitycheck
[460.842913] Dynamic subtest sanitycheck: SUCCESS (0.723s)
[460.853074] Starting dynamic subtest: shmem
[461.559366] Dynamic subtest shmem: SUCCESS (0.715s)
[461.568586] Starting dynamic subtest: fence
[469.700323] Dynamic subtest fence: SUCCESS (8.139s)
[469.709764] Starting dynamic subtest: scatterlist
[471.354480] Dynamic subtest scatterlist: SUCCESS (1.653s)
[471.369543] Starting dynamic subtest: syncmap
[474.583210] Dynamic subtest syncmap: SUCCESS (3.227s)
[474.593062] Starting dynamic subtest: uncore
[475.309067] Dynamic subtest uncore: SUCCESS (0.724s)
[475.318936] Starting dynamic subtest: ring
[475.997919] Dynamic subtest ring: SUCCESS (0.687s)
[476.007822] Starting dynamic subtest: engine
[476.701098] Dynamic subtest engine: SUCCESS (0.701s)
[476.710617] Starting dynamic subtest: timelines
[480.608745] Dynamic subtest timelines: SUCCESS (3.905s)
[480.618336] Starting dynamic subtest: requests
[484.659751] Dynamic subtest requests: SUCCESS (4.049s)
[484.669297] Starting dynamic subtest: objects
[485.492987] Dynamic subtest objects: SUCCESS (0.831s)
[485.502607] Starting dynamic subtest: phys
[486.323277] Dynamic subtest phys: SUCCESS (0.829s)
[486.337629] Starting dynamic subtest: dmabuf
[487.101297] Dynamic subtest dmabuf: SUCCESS (0.777s)
[487.110955] Starting dynamic subtest: vma
[492.724731] Dynamic subtest vma: SUCCESS (5.622s)
[492.734340] Starting dynamic subtest: evict
[494.230895] Dynamic subtest evict: SUCCESS (1.504s)
[494.240004] Starting dynamic subtest: gtt
[497.574953] Dynamic subtest gtt: SUCCESS (3.342s)
[497.587661] Starting dynamic subtest: hugepages
[498.507639] Dynamic subtest hugepages: SUCCESS (0.931s)
[498.517472] Starting dynamic subtest: memory_region
[502.635310] Dynamic subtest memory_region: SUCCESS (4.126s)
[502.637919] Subtest mock: SUCCESS (42.515s)
[502.666863] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[502.667516] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[502.670818] [105/130] (523s left) kms_flip (flip-vs-rmfb)
[504.175761] Starting subtest: flip-vs-rmfb
[504.177951] Starting dynamic subtest: A-eDP1
[512.897613] Dynamic subtest A-eDP1: SUCCESS (8.721s)
[512.907240] Starting dynamic subtest: B-eDP1
[521.626449] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[521.635979] Starting dynamic subtest: C-eDP1
[530.344144] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[530.359123] Starting dynamic subtest: D-eDP1
[539.073105] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[539.078745] Subtest flip-vs-rmfb: SUCCESS (34.899s)
[540.257776] [FACT kms_flip (flip-vs-rmfb)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[540.259015] [FACT kms_flip (flip-vs-rmfb)] new: kernel.kmod_is_loaded.i915: true
[540.263680] [106/130] (486s left) kms_psr (pr-sprite-blt)
[540.360603] Starting subtest: pr-sprite-blt
[540.364818] Subtest pr-sprite-blt: SKIP (0.000s)
[540.430636] [107/130] (486s left) gem_eio (wait-wedge-immediate)
[540.595168] Starting subtest: wait-wedge-immediate
[542.503983] Subtest wait-wedge-immediate: SUCCESS (1.908s)
[542.665506] [108/130] (483s left) gen9_exec_parse (bb-start-param)
[542.726834] Subtest bb-start-param: SKIP (0.000s)
[542.802837] [109/130] (483s left) gem_tiled_swapping (non-threaded)
[542.853037] Subtest non-threaded: SKIP (0.000s)
[542.908272] [110/130] (483s left) gem_userptr_blits (usage-restrictions)
[542.965934] Starting subtest: usage-restrictions
[542.967954] Subtest usage-restrictions: SUCCESS (0.000s)
[543.078829] [111/130] (483s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[543.183054] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[543.187197] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[543.281908] [112/130] (483s left) gem_create (create-invalid-size)
[543.344729] Starting subtest: create-invalid-size
[543.347017] Subtest create-invalid-size: SUCCESS (0.000s)
[543.533930] [113/130] (483s left) gem_exec_fence (expired-history)
[543.935943] Starting subtest: expired-history
[551.191608] Subtest expired-history: SUCCESS (7.256s)
[551.828017] [114/130] (474s left) gem_tiled_pread_basic
[551.960727] [115/130] (474s left) fbdev (eof)
[552.000101] Starting subtest: eof
[552.002428] Subtest eof: SUCCESS (0.000s)
[552.060941] [116/130] (474s left) gem_workarounds (reset-fd)
[552.121974] Starting subtest: reset-fd
[552.324527] Subtest reset-fd: SUCCESS (0.203s)
[552.478100] [117/130] (474s left) kms_psr (fbc-pr-cursor-blt)
[552.580468] Starting subtest: fbc-pr-cursor-blt
[552.584797] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[552.655233] [118/130] (474s left) gem_exec_reloc (basic-range-active)
[552.712359] Subtest basic-range-active: SKIP (0.000s)
[552.779800] [119/130] (474s left) kms_chamelium_edid (hdmi-edid-read)
[553.172285] Subtest hdmi-edid-read: SKIP (0.000s)
[553.955452] [120/130] (473s left) i915_fb_tiling (basic-x-tiling)
[554.019906] Subtest basic-x-tiling: SKIP (0.000s)
[554.075829] [121/130] (472s left) kms_plane_cursor (primary)
[554.172824] Starting subtest: primary
[554.177323] Starting dynamic subtest: pipe-A-eDP-1-size-64
[557.045228] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.870s)
[557.068741] Starting dynamic subtest: pipe-A-eDP-1-size-128
[559.914299] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.851s)
[559.943280] Starting dynamic subtest: pipe-A-eDP-1-size-256
[562.835575] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.904s)
[563.155051] Starting dynamic subtest: pipe-B-eDP-1-size-64
[566.685106] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.542s)
[566.709060] Starting dynamic subtest: pipe-B-eDP-1-size-128
[569.532156] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.829s)
[569.554270] Starting dynamic subtest: pipe-B-eDP-1-size-256
[572.320338] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.771s)
[572.634943] Starting dynamic subtest: pipe-C-eDP-1-size-64
[575.731844] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.108s)
[575.759776] Starting dynamic subtest: pipe-C-eDP-1-size-128
[578.210403] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.457s)
[578.236666] Starting dynamic subtest: pipe-C-eDP-1-size-256
[580.665211] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.435s)
[580.982042] Starting dynamic subtest: pipe-D-eDP-1-size-64
[584.188630] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.218s)
[584.216659] Starting dynamic subtest: pipe-D-eDP-1-size-128
[586.633910] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.424s)
[586.661531] Starting dynamic subtest: pipe-D-eDP-1-size-256
[589.200705] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.547s)
[589.509385] Subtest primary: SUCCESS (35.334s)
[590.371772] [122/130] (436s left) gem_exec_schedule (pi-shared-iova)
[590.546641] Starting subtest: pi-shared-iova
[590.548688] Starting dynamic subtest: rcs0
[590.620649] Dynamic subtest rcs0: SUCCESS (0.076s)
[590.633433] Starting dynamic subtest: vcs0
[590.682629] Dynamic subtest vcs0: SUCCESS (0.062s)
[590.695358] Starting dynamic subtest: vcs1
[590.743113] Dynamic subtest vcs1: SUCCESS (0.058s)
[590.754966] Starting dynamic subtest: vecs0
[590.803589] Dynamic subtest vecs0: SUCCESS (0.059s)
[590.815618] Starting dynamic subtest: ccs0
[590.870199] Dynamic subtest ccs0: SUCCESS (0.067s)
[590.872791] Subtest pi-shared-iova: SUCCESS (0.327s)
[592.566309] [123/130] (434s left) gem_exec_schedule (u-fairslice-all)
[592.637089] Starting subtest: u-fairslice-all
[594.693312] Subtest u-fairslice-all: SUCCESS (2.061s)
[594.992374] [124/130] (432s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[595.098221] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[595.102487] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[595.214038] [125/130] (432s left) kms_addfb_basic (invalid-set-prop)
[595.278198] Starting subtest: invalid-set-prop
[595.280654] Subtest invalid-set-prop: SUCCESS (0.000s)
[595.426628] [126/130] (431s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[595.540343] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[595.544562] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[595.666574] [127/130] (431s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[595.723894] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[595.728829] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[595.909745] [128/130] (431s left) gem_ctx_param (invalid-set-no-zeromap)
[595.958276] Starting subtest: invalid-set-no-zeromap
[595.960591] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[596.034485] [129/130] (431s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[596.144305] Starting subtest: 4-tiled-addfb-size-offset-overflow
[596.146695] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[596.243148] [130/130] (431s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[596.359456] Starting subtest: cursorA-vs-flipB-varying-size
[596.364030] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[596.501645] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: gem_ctx_sseu
results: parsing output: 6/ for test: kms_rotation_crc
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gem_flink_race
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: kms_selftest
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_dsc
results: parsing output: 16/ for test: prime_busy
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: kms_pipe_crc_basic
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: gem_mmap_wc
results: parsing output: 25/ for test: vgem_basic
results: parsing output: 26/ for test: gem_ctx_shared
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_mmap
results: parsing output: 29/ for test: kms_joiner
results: parsing output: 30/ for test: gen3_mixed_blits
results: parsing output: 31/ for test: kms_setmode
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_hdmi_inject
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_chamelium_color
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: i915_pm_rc6_residency
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: i915_pm_rps
results: parsing output: 46/ for test: kms_vrr
results: parsing output: 47/ for test: drm_read
results: parsing output: 48/ for test: gem_exec_flush
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: gem_reg_read
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_request_retire
results: parsing output: 53/ for test: kms_atomic_transition
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_force_connector_basic
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: kms_universal_plane
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: kms_draw_crc
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: syncobj_eventfd
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_backlight
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_async_flips
results: parsing output: 71/ for test: gem_ctx_freq
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_pxp
results: parsing output: 78/ for test: gem_busy
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_cursor_edge_walk
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: i915_selftest
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: gen9_exec_parse
results: parsing output: 108/ for test: gem_tiled_swapping
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_create
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: gem_tiled_pread_basic
results: parsing output: 114/ for test: fbdev
results: parsing output: 115/ for test: gem_workarounds
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: kms_chamelium_edid
results: parsing output: 119/ for test: i915_fb_tiling
results: parsing output: 120/ for test: kms_plane_cursor
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_ctx_param
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_cursor_legacy
Done.