[58.058446] Initializing watchdogs
[58.058492]   /dev/watchdog0
[58.072584] [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.077149] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.079801] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.083119] [001/133] (960s left) prime_mmap (test_errors)
[58.155875] Starting subtest: test_errors
[58.158314] Starting dynamic subtest: test_errors-smem
[58.249836] Dynamic subtest test_errors-smem: SUCCESS (0.095s)
[58.252304] Subtest test_errors: SUCCESS (0.095s)
[58.335357] [002/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[58.438217] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[62.867687] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.420s)
[63.986818] [003/133] (954s left) gem_create (hog-create)
[64.043711] Starting subtest: hog-create
[64.046442] Starting dynamic subtest: smem0
[97.944904] Dynamic subtest smem0: SUCCESS (33.883s)
[97.947190] Subtest hog-create: SUCCESS (33.884s)
[98.124346] [004/133] (920s left) api_intel_bb (misplaced-blitter)
[98.196948] Starting subtest: misplaced-blitter
[98.206567] Subtest misplaced-blitter: SUCCESS (0.011s)
[98.336728] [005/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[98.440401] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[98.444889] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[98.544407] [006/133] (920s left) gem_exec_params (readonly)
[98.613021] Starting subtest: readonly
[98.617886] Subtest readonly: SUCCESS (0.003s)
[98.729136] [007/133] (920s left) kms_cursor_edge_walk (128x128-right-edge)
[98.821969] Starting subtest: 128x128-right-edge
[98.824296] Starting dynamic subtest: pipe-A-eDP-1
[102.257341] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[102.266085] Starting dynamic subtest: pipe-D-eDP-1
[105.396446] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s)
[105.398707] Subtest 128x128-right-edge: SUCCESS (6.574s)
[106.201492] [008/133] (912s left) i915_suspend (basic-s3-without-i915)
[106.240606] Starting subtest: basic-s3-without-i915
[107.953806] Subtest basic-s3-without-i915: SKIP (1.709s)
[109.502668] [009/133] (909s left) gem_exec_schedule (u-fairslice-all)
[109.580324] Starting subtest: u-fairslice-all
[111.641545] Subtest u-fairslice-all: SUCCESS (2.068s)
[112.992510] [010/133] (905s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[113.044560] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[113.117105] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.016s)
[113.155785] [011/133] (905s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[113.247297] Starting subtest: coverage-vs-premult-vs-constant
[113.548508] Starting dynamic subtest: pipe-A-eDP-1
[114.137690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.589s)
[114.146390] Starting dynamic subtest: pipe-D-eDP-1
[115.477240] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[115.479643] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.230s)
[116.332948] [012/133] (902s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[116.431148] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[116.435632] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[116.509982] [013/133] (902s left) kms_async_flips (test-time-stamp-atomic)
[116.588423] Starting subtest: test-time-stamp-atomic
[116.972863] Starting dynamic subtest: pipe-A-eDP-1
[117.742368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.769s)
[118.132376] Starting dynamic subtest: pipe-B-eDP-1
[118.889792] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[119.265781] Starting dynamic subtest: pipe-C-eDP-1
[120.030384] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[120.397511] Starting dynamic subtest: pipe-D-eDP-1
[121.164052] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[121.166487] Subtest test-time-stamp-atomic: SUCCESS (4.575s)
[122.324802] [014/133] (896s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[122.432036] Starting subtest: 4-tiled-16bpp-rotate-90
[122.454449] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[122.560527] [015/133] (896s left) gem_eio (hibernate)
[122.790667] Starting subtest: hibernate
[137.401866] Subtest hibernate: SUCCESS (14.611s)
[144.557312] [016/133] (881s left) i915_module_load (resize-bar)
[144.626186] Starting subtest: resize-bar
[144.632436] Subtest resize-bar: SKIP (0.006s)
[144.680064] [017/133] (881s left) kms_chamelium_frames (dp-crc-single)
[145.087653] Subtest dp-crc-single: SKIP (0.000s)
[145.864739] [018/133] (880s left) kms_psr (psr2-sprite-plane-move)
[145.956199] Starting subtest: psr2-sprite-plane-move
[145.958644] Starting dynamic subtest: eDP-1
[147.711591] Dynamic subtest eDP-1: SUCCESS (1.756s)
[147.713764] Subtest psr2-sprite-plane-move: SUCCESS (1.757s)
[148.559650] [019/133] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[148.672172] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[148.676184] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[148.772231] [020/133] (877s left) gem_mmap_gtt (bad-object)
[148.828260] Subtest bad-object: SKIP (0.000s)
[148.885613] [021/133] (877s left) perf_pmu (interrupts-sync)
[148.927230] Starting subtest: interrupts-sync
[150.034429] Subtest interrupts-sync: SUCCESS (1.107s)
[150.139503] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[150.142756] [022/133] (876s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[150.266183] Starting subtest: cursorA-vs-flipB-atomic
[150.270741] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[150.410616] [023/133] (876s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[150.466955] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[150.578329] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.110s)
[150.652814] [024/133] (875s left) gem_ctx_create (basic)
[150.712951] Starting subtest: basic
[150.715713] Subtest basic: SUCCESS (0.000s)
[150.904218] [025/133] (875s left) gem_exec_schedule (noreorder)
[151.082981] Starting subtest: noreorder
[151.085809] Starting dynamic subtest: rcs0
[151.142527] Dynamic subtest rcs0: SUCCESS (0.060s)
[151.153784] Starting dynamic subtest: vcs0
[152.909851] Dynamic subtest vcs0: SUCCESS (1.766s)
[152.922345] Starting dynamic subtest: vcs1
[154.898713] Dynamic subtest vcs1: SUCCESS (1.987s)
[154.910877] Starting dynamic subtest: vecs0
[156.889757] Dynamic subtest vecs0: SUCCESS (1.990s)
[156.901727] Starting dynamic subtest: ccs0
[156.934467] Dynamic subtest ccs0: SUCCESS (0.046s)
[156.936923] Subtest noreorder: SUCCESS (5.853s)
[157.133029] [026/133] (869s left) gem_softpin (evict-active-interruptible)
[157.197035] Starting subtest: evict-active-interruptible
[157.205440] Subtest evict-active-interruptible: SUCCESS (0.009s)
[157.340328] [027/133] (869s left) kms_pm_rpm (basic-pci-d3-state)
[158.974059] Starting subtest: basic-pci-d3-state
[160.471737] Subtest basic-pci-d3-state: SUCCESS (1.499s)
[160.558569] [028/133] (866s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[160.660753] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[164.792335] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.135s)
[165.928892] [029/133] (860s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[166.021730] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[166.026066] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[166.121150] [030/133] (860s left) gem_eio (unwedge-stress)
[166.347763] Starting subtest: unwedge-stress
[166.349634] Starting dynamic subtest: render
[170.969931] Dynamic subtest render: SUCCESS (4.620s)
[170.986063] Starting dynamic subtest: bsd1
[191.336448] Dynamic subtest bsd1: SUCCESS (20.366s)
[191.351902] Starting dynamic subtest: bsd2
[209.384631] Dynamic subtest bsd2: SUCCESS (18.049s)
[209.400907] Starting dynamic subtest: blt
[209.405306] Dynamic subtest blt: SKIP (0.000s)
[209.414246] Starting dynamic subtest: vebox
[227.372860] Dynamic subtest vebox: SUCCESS (17.987s)
[227.375221] Subtest unwedge-stress: SUCCESS (61.024s)
[228.943250] [031/133] (797s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[229.057139] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[229.061652] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[229.169811] [032/133] (797s left) gem_exec_fence (submit67)
[229.345584] Starting subtest: submit67
[229.350294] Subtest submit67: SKIP (0.000s)
[230.940254] [033/133] (795s left) kms_chamelium_hpd (dp-hpd-storm)
[231.318624] Subtest dp-hpd-storm: SKIP (0.000s)
[232.143504] [034/133] (794s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[232.234195] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[232.236577] Starting dynamic subtest: pipe-A-default-mode
[235.013736] Dynamic subtest pipe-A-default-mode: SUCCESS (2.777s)
[235.016034] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.778s)
[235.857648] [035/133] (791s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[235.968360] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[244.970608] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.002s)
[245.770329] [036/133] (781s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[245.881584] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[253.269210] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.390s)
[253.417344] [037/133] (773s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[253.505558] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[253.508664] Starting dynamic subtest: pipe-A
[253.526628] Dynamic subtest pipe-A: SKIP (0.017s)
[253.537720] Starting dynamic subtest: pipe-B
[253.560245] Dynamic subtest pipe-B: SKIP (0.035s)
[253.570083] Starting dynamic subtest: pipe-C
[253.594198] Dynamic subtest pipe-C: SKIP (0.034s)
[253.603600] Starting dynamic subtest: pipe-D
[253.626398] Dynamic subtest pipe-D: SKIP (0.031s)
[253.630559] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.119s)
[253.720512] [038/133] (773s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[253.803029] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[253.807254] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[253.875343] [039/133] (773s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[253.977094] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[260.820462] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.845s)
[260.956498] [040/133] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[261.067274] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[261.071216] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[261.162287] [041/133] (766s left) kms_cursor_crc (cursor-onscreen-256x85)
[261.441704] Starting subtest: cursor-onscreen-256x85
[261.484997] Subtest cursor-onscreen-256x85: SKIP (0.040s)
[261.672101] [042/133] (765s left) kms_psr (fbc-pr-primary-render)
[261.772843] Starting subtest: fbc-pr-primary-render
[261.777176] Subtest fbc-pr-primary-render: SKIP (0.000s)
[261.846600] [043/133] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[261.942506] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[265.842680] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.904s)
[267.005109] [044/133] (760s left) kms_dp_link_training (non-uhbr-sst)
[267.098378] Starting subtest: non-uhbr-sst
[267.107231] Subtest non-uhbr-sst: SKIP (0.000s)
[267.185670] [045/133] (760s left) gem_ctx_isolation (preservation)
[267.238752] Starting subtest: preservation
[267.241301] Starting dynamic subtest: rcs0
[267.367730] Dynamic subtest rcs0: SUCCESS (0.128s)
[267.378300] Starting dynamic subtest: bcs0
[267.500046] Dynamic subtest bcs0: SUCCESS (0.132s)
[267.510240] Starting dynamic subtest: vcs0
[267.636471] Dynamic subtest vcs0: SUCCESS (0.135s)
[267.649074] Starting dynamic subtest: vcs1
[268.991618] Dynamic subtest vcs1: SUCCESS (1.354s)
[269.004666] Starting dynamic subtest: vecs0
[271.049704] Dynamic subtest vecs0: SUCCESS (2.058s)
[271.062329] Starting dynamic subtest: ccs0
[273.065405] Dynamic subtest ccs0: SUCCESS (2.014s)
[273.068109] Subtest preservation: SUCCESS (5.827s)
[273.320584] [046/133] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[273.434711] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[280.578348] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.147s)
[280.702838] [047/133] (746s left) kms_psr (psr-sprite-mmap-cpu)
[280.799653] Starting subtest: psr-sprite-mmap-cpu
[280.801904] Starting dynamic subtest: eDP-1
[282.529576] Dynamic subtest eDP-1: SUCCESS (1.729s)
[282.531707] Subtest psr-sprite-mmap-cpu: SUCCESS (1.730s)
[283.366991] [048/133] (744s left) dumb_buffer (invalid-bpp)
[283.429124] Starting subtest: invalid-bpp
[283.431289] Subtest invalid-bpp: SUCCESS (0.000s)
[283.520594] [049/133] (744s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[283.617569] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[283.621966] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[283.707636] [050/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[283.800780] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[283.804747] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[283.904719] [051/133] (743s left) kms_selftest (drm_cmdline_parser)
[283.946422] Starting subtest: drm_cmdline_parser
[283.967265] Starting dynamic subtest: drm_test_cmdline_force_d_only
[284.076316] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.107s)
[284.085797] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[284.174669] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.097s)
[284.185497] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[284.289652] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.116s)
[284.299908] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[284.397083] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.105s)
[284.406530] Starting dynamic subtest: drm_test_cmdline_force_e_only
[284.506106] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.108s)
[284.515887] Starting dynamic subtest: drm_test_cmdline_res
[284.602314] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.094s)
[284.613316] Starting dynamic subtest: drm_test_cmdline_res_vesa
[284.690253] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.087s)
[284.702090] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[284.780827] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.091s)
[284.789824] Starting dynamic subtest: drm_test_cmdline_res_rblank
[284.896856] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.114s)
[284.907471] Starting dynamic subtest: drm_test_cmdline_res_bpp
[284.995234] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.094s)
[285.004309] Starting dynamic subtest: drm_test_cmdline_res_refresh
[285.083972] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.088s)
[285.094561] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[285.167157] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.084s)
[285.175689] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[285.269104] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.101s)
[285.278134] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[285.354330] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.084s)
[285.362924] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[285.438057] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.083s)
[285.446454] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[285.528382] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.089s)
[285.538065] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[285.626878] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.099s)
[285.635461] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[285.732395] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.103s)
[285.742148] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[285.834950] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.102s)
[285.843456] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[285.927269] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.091s)
[285.937182] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[286.013206] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.086s)
[286.023133] Starting dynamic subtest: drm_test_cmdline_name
[286.108320] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.094s)
[286.118359] Starting dynamic subtest: drm_test_cmdline_name_bpp
[286.189348] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.080s)
[286.198665] Starting dynamic subtest: drm_test_cmdline_name_option
[286.278225] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.089s)
[286.288144] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[286.381095] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.102s)
[286.390713] Starting dynamic subtest: drm_test_cmdline_rotate_0
[286.468304] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.086s)
[286.478279] Starting dynamic subtest: drm_test_cmdline_rotate_90
[286.553199] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.084s)
[286.563083] Starting dynamic subtest: drm_test_cmdline_rotate_180
[286.636360] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.083s)
[286.647130] Starting dynamic subtest: drm_test_cmdline_rotate_270
[286.725092] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.087s)
[286.736476] Starting dynamic subtest: drm_test_cmdline_hmirror
[286.821409] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.093s)
[286.831339] Starting dynamic subtest: drm_test_cmdline_vmirror
[286.908652] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.088s)
[286.917597] Starting dynamic subtest: drm_test_cmdline_margin_options
[286.992496] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.082s)
[287.002785] Starting dynamic subtest: drm_test_cmdline_multiple_options
[287.085432] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.093s)
[287.095555] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[287.168080] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.082s)
[287.178280] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[287.262569] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.094s)
[287.272856] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[287.353137] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.090s)
[287.363841] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[287.440233] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.085s)
[287.448487] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[287.532764] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.092s)
[287.541492] Starting dynamic subtest: drm_test_cmdline_invalid
[287.629723] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.096s)
[287.637965] Starting dynamic subtest: drm_test_cmdline_tv_options
[287.724887] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.096s)
[287.726810] Subtest drm_cmdline_parser: SUCCESS (3.780s)
[287.892330] [052/133] (739s left) sw_sync (sync_busy_fork)
[287.928651] Starting subtest: sync_busy_fork
[288.944083] Subtest sync_busy_fork: SUCCESS (1.016s)
[289.058920] [053/133] (738s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[289.128651] Starting subtest: multi-wait-for-submit-submitted-signaled
[289.131087] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[289.228358] [054/133] (738s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[289.291063] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[289.407072] [055/133] (738s left) perf (sysctl-defaults)
[289.480554] Starting subtest: sysctl-defaults
[289.482809] Subtest sysctl-defaults: SUCCESS (0.000s)
[289.573377] [056/133] (738s left) kms_psr (psr2-cursor-mmap-cpu)
[289.666261] Starting subtest: psr2-cursor-mmap-cpu
[289.668538] Starting dynamic subtest: eDP-1
[291.333899] Dynamic subtest eDP-1: SUCCESS (1.668s)
[291.336284] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.669s)
[292.138635] [057/133] (735s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[292.196183] Starting subtest: y-tiled-ccs-to-x-tiled
[292.200363] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[292.398695] [058/133] (735s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[292.488634] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[296.196211] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.711s)
[297.360188] [059/133] (730s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[297.498874] Starting subtest: dp-mst-lic-type-0-hdcp14
[297.503105] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[297.632790] [060/133] (730s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[297.745882] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[298.956402] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: FAIL (0.607s)
[298.997502] [061/133] (729s left) kms_tv_load_detect (load-detect)
[299.054879] Subtest load-detect: SKIP (0.000s)
[299.114548] [062/133] (729s left) kms_flip (absolute-wf_vblank)
[299.212025] Starting subtest: absolute-wf_vblank
[299.213648] Starting dynamic subtest: A-eDP1
[307.907076] Dynamic subtest A-eDP1: SUCCESS (8.695s)
[307.916583] Starting dynamic subtest: B-eDP1
[316.634081] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[316.647092] Starting dynamic subtest: C-eDP1
[325.346341] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[325.355930] Starting dynamic subtest: D-eDP1
[334.079456] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[334.084403] Subtest absolute-wf_vblank: SUCCESS (34.872s)
[335.298613] [063/133] (692s left) gem_ppgtt (blt-vs-render-ctx0)
[335.352628] Starting subtest: blt-vs-render-ctx0
[368.207644] Subtest blt-vs-render-ctx0: SUCCESS (32.852s)
[368.338709] [064/133] (659s left) i915_pm_rpm (gem-mmap-type)
[370.053034] Starting subtest: gem-mmap-type
[370.055768] Starting dynamic subtest: wb-smem0
[373.851532] Dynamic subtest wb-smem0: SUCCESS (3.800s)
[373.862052] Starting dynamic subtest: wc-smem0
[377.041576] Dynamic subtest wc-smem0: SUCCESS (3.189s)
[377.051567] Starting dynamic subtest: uc-smem0
[380.253754] Dynamic subtest uc-smem0: SUCCESS (3.212s)
[380.256169] Subtest gem-mmap-type: SUCCESS (10.204s)
[380.388879] [065/133] (647s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[380.451790] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[380.520775] [066/133] (647s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[380.605452] Starting subtest: plane-downscale-factor-0-5-with-rotation
[380.607822] Starting dynamic subtest: pipe-A
[380.624854] Dynamic subtest pipe-A: SKIP (0.016s)
[380.635246] Starting dynamic subtest: pipe-B
[380.655305] Dynamic subtest pipe-B: SKIP (0.029s)
[380.667273] Starting dynamic subtest: pipe-C
[380.684317] Dynamic subtest pipe-C: SKIP (0.029s)
[380.696053] Starting dynamic subtest: pipe-D
[380.713018] Dynamic subtest pipe-D: SKIP (0.028s)
[380.717342] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.105s)
[380.818104] [067/133] (647s left) syncobj_timeline (wait-zero-handles)
[380.883778] Starting subtest: wait-zero-handles
[380.886154] Subtest wait-zero-handles: SUCCESS (0.000s)
[380.973800] [068/133] (647s left) kms_cdclk (mode-transition-all-outputs)
[381.074805] Starting subtest: mode-transition-all-outputs
[381.360740] Subtest mode-transition-all-outputs: SKIP (0.285s)
[382.242488] [069/133] (646s left) gem_partial_pwrite_pread (reads)
[382.312210] Subtest reads: SKIP (0.000s)
[382.392201] [070/133] (646s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[382.438944] Starting subtest: y-tiled-to-vebox-x-tiled
[382.443429] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[382.623074] [071/133] (645s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[382.718372] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[382.729226] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[382.806308] [072/133] (645s left) gem_exec_balancer (parallel-bb-first)
[383.069359] Starting subtest: parallel-bb-first
[384.019144] Subtest parallel-bb-first: SUCCESS (0.950s)
[384.957970] [073/133] (643s left) gem_exercise_blt (fast-copy)
[385.015489] Starting subtest: fast-copy
[385.017793] Starting dynamic subtest: linear-smem-smem
[385.035129] Dynamic subtest linear-smem-smem: SUCCESS (0.022s)
[385.049167] Starting dynamic subtest: xmajor-smem-smem
[385.054194] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[385.063645] Starting dynamic subtest: tile4-smem-smem
[385.071729] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[385.081297] Starting dynamic subtest: tile64-smem-smem
[385.089524] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[385.091900] Subtest fast-copy: SUCCESS (0.077s)
[385.224778] [074/133] (643s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[385.319778] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[385.329377] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[385.420655] [075/133] (643s left) perf_pmu (busy-double-start)
[385.461427] Starting subtest: busy-double-start
[385.463811] Starting dynamic subtest: rcs0
[389.102036] Dynamic subtest rcs0: FAIL (3.590s)
[389.113874] Starting dynamic subtest: bcs0
[392.617513] Dynamic subtest bcs0: SUCCESS (3.572s)
[392.628979] Starting dynamic subtest: vcs0
[396.442759] Dynamic subtest vcs0: SUCCESS (3.824s)
[396.455500] Starting dynamic subtest: vcs1
[400.406645] Dynamic subtest vcs1: SUCCESS (3.961s)
[400.420178] Starting dynamic subtest: vecs0
[404.475929] Dynamic subtest vecs0: SUCCESS (4.067s)
[404.489105] Starting dynamic subtest: ccs0
[408.113535] Dynamic subtest ccs0: FAIL (3.566s)
[408.115506] Subtest busy-double-start: FAIL (22.590s)
[408.161018] [076/133] (620s left) gem_pread (self)
[408.226789] Subtest self: SKIP (0.000s)
[408.288692] [077/133] (620s left) kms_busy (extended-pageflip-hang-newfb)
[408.393060] Starting subtest: extended-pageflip-hang-newfb
[408.395398] Starting dynamic subtest: pipe-A
[434.667952] Dynamic subtest pipe-A: SUCCESS (26.273s)
[434.678788] Starting dynamic subtest: pipe-D
[459.697212] Dynamic subtest pipe-D: SUCCESS (25.025s)
[459.699417] Subtest extended-pageflip-hang-newfb: SUCCESS (51.302s)
[460.496667] [078/133] (568s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[460.596992] Starting subtest: y-tiled-64bpp-rotate-0
[460.601465] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[460.700301] [079/133] (568s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[460.756664] Starting subtest: etime-single-wait-for-submit-unsubmitted
[460.865546] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.109s)
[460.946302] [080/133] (568s left) kms_flip (2x-flip-vs-dpms-on-nop)
[461.033184] Starting subtest: 2x-flip-vs-dpms-on-nop
[461.044046] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[461.148702] [081/133] (567s left) gen3_render_linear_blits
[461.260060] [082/133] (567s left) kms_joiner (basic-force-ultra-joiner)
[461.369284] Starting subtest: basic-force-ultra-joiner
[461.373368] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[461.435731] [083/133] (567s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[461.523805] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[461.526113] Starting dynamic subtest: pipe-A-eDP-1
[461.549120] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[461.560350] Starting dynamic subtest: pipe-B-eDP-1
[461.582236] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[461.591768] Starting dynamic subtest: pipe-C-eDP-1
[461.613701] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[461.623293] Starting dynamic subtest: pipe-D-eDP-1
[461.645381] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[461.649487] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[463.793989] [084/133] (565s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[463.898507] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[463.902852] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[463.987416] [085/133] (565s left) gem_pxp (reject-modify-context-protection-off-2)
[464.108748] Starting subtest: reject-modify-context-protection-off-2
[464.111173] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[464.227249] [086/133] (565s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[464.334277] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[464.336484] Starting dynamic subtest: pipe-A-eDP-1
[464.359233] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[464.371572] Starting dynamic subtest: pipe-B-eDP-1
[464.392061] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[464.402117] Starting dynamic subtest: pipe-C-eDP-1
[464.423060] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[464.433735] Starting dynamic subtest: pipe-D-eDP-1
[464.457087] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[464.461327] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.007s)
[466.636366] [087/133] (562s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[466.741297] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[466.745149] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[466.824275] [088/133] (562s left) kms_psr (fbc-psr2-sprite-plane-move)
[466.911930] Starting subtest: fbc-psr2-sprite-plane-move
[466.914188] Starting dynamic subtest: eDP-1
[466.918211] Dynamic subtest eDP-1: SKIP (0.000s)
[466.922302] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[466.986059] [089/133] (562s left) gem_exec_reloc (basic-wc-read-active)
[467.045477] Subtest basic-wc-read-active: SKIP (0.000s)
[467.119735] [090/133] (562s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[467.213985] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[467.217888] Starting dynamic subtest: pipe-A-eDP-1
[467.288428] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[467.300974] Starting dynamic subtest: pipe-B-eDP-1
[468.422071] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[468.426678] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.212s)
[469.627532] [091/133] (559s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[469.723261] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[469.727671] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[469.814430] [092/133] (559s left) gem_exec_balancer (waits)
[469.887392] Starting subtest: waits
[476.406574] Subtest waits: SUCCESS (6.518s)
[476.702104] [093/133] (552s left) gem_ctx_sseu (mmap-args)
[476.766476] Subtest mmap-args: SKIP (0.000s)
[476.835718] [094/133] (552s left) gem_wait (write-busy)
[476.908774] Starting subtest: write-busy
[476.911044] Starting dynamic subtest: all-engines
[477.538733] Dynamic subtest all-engines: SUCCESS (0.629s)
[477.554424] Starting dynamic subtest: rcs0
[478.097321] Dynamic subtest rcs0: SUCCESS (0.557s)
[478.115458] Starting dynamic subtest: bcs0
[478.650464] Dynamic subtest bcs0: SUCCESS (0.552s)
[478.667854] Starting dynamic subtest: vcs0
[479.892451] Dynamic subtest vcs0: SUCCESS (1.239s)
[479.910476] Starting dynamic subtest: vcs1
[481.878789] Dynamic subtest vcs1: SUCCESS (1.983s)
[481.896413] Starting dynamic subtest: vecs0
[483.924620] Dynamic subtest vecs0: SUCCESS (2.043s)
[483.942966] Starting dynamic subtest: ccs0
[484.474145] Dynamic subtest ccs0: SUCCESS (0.549s)
[484.476594] Subtest write-busy: SUCCESS (7.565s)
[484.674627] [095/133] (544s left) gem_mmap_offset (partial-mmap)
[484.744543] Starting subtest: partial-mmap
[484.746570] Starting dynamic subtest: smem0
[484.748592] Dynamic subtest smem0: SUCCESS (0.006s)
[484.751414] Subtest partial-mmap: SUCCESS (0.006s)
[484.855616] [096/133] (544s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[484.956486] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[492.324426] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.371s)
[492.453961] [097/133] (537s left) gem_ctx_persistence (hang)
[492.506431] Starting subtest: hang
[492.510993] Subtest hang: SKIP (0.000s)
[492.613433] [098/133] (537s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[492.709399] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[492.713508] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[492.791730] [099/133] (537s left) fbdev (eof)
[492.833102] Starting subtest: eof
[492.835311] Subtest eof: SUCCESS (0.000s)
[492.905942] [100/133] (536s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[492.959605] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[492.961787] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[493.043922] [101/133] (536s left) kms_vblank (query-forked-busy-hang)
[493.132750] Starting subtest: query-forked-busy-hang
[493.134972] Starting dynamic subtest: pipe-A-eDP-1
[519.705527] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.570s)
[519.720626] Starting dynamic subtest: pipe-D-eDP-1
[534.683106] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.974s)
[534.685408] Subtest query-forked-busy-hang: SUCCESS (41.549s)
[535.531722] [102/133] (494s left) kms_color (legacy-gamma-reset)
[535.639586] Starting subtest: legacy-gamma-reset
[535.641763] Starting dynamic subtest: pipe-A-eDP-1
[536.018443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s)
[536.030415] Starting dynamic subtest: pipe-B-eDP-1
[536.032761] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[536.042499] Starting dynamic subtest: pipe-C-eDP-1
[536.044866] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[536.054565] Starting dynamic subtest: pipe-D-eDP-1
[536.056899] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[536.059259] Subtest legacy-gamma-reset: SUCCESS (0.414s)
[536.862339] [103/133] (493s left) gem_flink_race (flink_close)
[536.899193] Starting subtest: flink_close
[541.965341] Subtest flink_close: SUCCESS (5.066s)
[542.095579] [104/133] (487s left) gem_ctx_param (invalid-size-get)
[542.164054] Starting subtest: invalid-size-get
[542.166465] Subtest invalid-size-get: SUCCESS (0.001s)
[542.290102] [105/133] (487s left) kms_psr (fbc-pr-primary-blt)
[542.404242] Starting subtest: fbc-pr-primary-blt
[542.408224] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[542.500529] [106/133] (487s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[542.592167] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[542.594764] Starting dynamic subtest: pipe-A-eDP-1
[543.054752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[543.066712] Starting dynamic subtest: pipe-B-eDP-1
[544.499609] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[544.511731] Starting dynamic subtest: pipe-C-eDP-1
[545.855706] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[545.866577] Starting dynamic subtest: pipe-D-eDP-1
[547.173839] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[547.176095] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.557s)
[548.276597] [107/133] (481s left) kms_plane_multiple (2x-tiling-y)
[548.364758] Starting subtest: 2x-tiling-y
[548.369512] Subtest 2x-tiling-y: SKIP (0.000s)
[548.435434] [108/133] (481s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[548.541072] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[548.545430] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[548.623026] [109/133] (481s left) gem_exec_flush (basic-uc-set-default)
[548.691523] Starting subtest: basic-uc-set-default
[554.146526] Subtest basic-uc-set-default: SUCCESS (5.456s)
[554.351490] [110/133] (475s left) syncobj_timeline (single-wait-available-signaled)
[554.407199] Starting subtest: single-wait-available-signaled
[554.409505] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[554.501389] [111/133] (475s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[554.601311] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[555.713804] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.112s)
[555.837496] [112/133] (474s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[555.943940] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[562.746100] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.803s)
[562.892516] [113/133] (467s left) kms_flip (2x-dpms-vs-vblank-race)
[562.983811] Starting subtest: 2x-dpms-vs-vblank-race
[562.992603] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[563.073635] [114/133] (467s left) api_intel_allocator (two-level-inception)
[563.134759] Starting subtest: two-level-inception
[568.533125] Subtest two-level-inception: SUCCESS (5.399s)
[568.670184] [115/133] (461s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[568.789570] Starting subtest: psr-rgb101010-draw-mmap-wc
[575.830212] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.043s)
[575.954287] [116/133] (454s left) kms_rotation_crc (sprite-rotation-90)
[576.046963] Starting subtest: sprite-rotation-90
[576.051129] Subtest sprite-rotation-90: SKIP (0.001s)
[576.121292] [117/133] (454s left) kms_pm_rpm (pc8-residency)
[578.147426] Starting subtest: pc8-residency
[578.153060] Subtest pc8-residency: SKIP (0.000s)
[578.540534] [118/133] (452s left) i915_drm_fdinfo (basics)
[578.583042] Starting subtest: basics
[578.585382] Subtest basics: SUCCESS (0.000s)
[578.658552] [119/133] (452s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[578.752704] Starting subtest: bad-pixel-format-y-tiled-ccs
[578.754940] Starting dynamic subtest: pipe-A-eDP-1
[578.785612] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[578.796647] Starting dynamic subtest: pipe-B-eDP-1
[578.818898] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[578.828742] Starting dynamic subtest: pipe-C-eDP-1
[578.851054] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[578.865075] Starting dynamic subtest: pipe-D-eDP-1
[578.887090] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[578.891372] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[580.979772] [120/133] (449s left) perf_pmu (init-busy)
[581.027604] Starting subtest: init-busy
[581.030132] Starting dynamic subtest: rcs0
[581.032543] Dynamic subtest rcs0: SUCCESS (0.001s)
[581.044087] Starting dynamic subtest: bcs0
[581.045965] Dynamic subtest bcs0: SUCCESS (0.000s)
[581.055247] Starting dynamic subtest: vcs0
[581.057106] Dynamic subtest vcs0: SUCCESS (0.001s)
[581.066270] Starting dynamic subtest: vcs1
[581.068139] Dynamic subtest vcs1: SUCCESS (0.000s)
[581.077271] Starting dynamic subtest: vecs0
[581.079138] Dynamic subtest vecs0: SUCCESS (0.000s)
[581.089053] Starting dynamic subtest: ccs0
[581.091330] Dynamic subtest ccs0: SUCCESS (0.000s)
[581.093490] Subtest init-busy: SUCCESS (0.007s)
[581.144306] [121/133] (449s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[581.315621] Starting subtest: cursor-rapid-movement-64x64
[581.320298] Starting dynamic subtest: pipe-A-eDP-1
[581.848694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[581.878395] Starting dynamic subtest: pipe-D-eDP-1
[583.095650] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[583.097578] Subtest cursor-rapid-movement-64x64: SUCCESS (1.778s)
[583.931434] [122/133] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[584.029826] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[584.034096] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[584.127263] [123/133] (446s left) gem_softpin (evict-active)
[584.205361] Starting subtest: evict-active
[584.212106] Subtest evict-active: SUCCESS (0.006s)
[584.336939] [124/133] (446s left) gem_exec_schedule (u-submit-golden-slice)
[584.409577] Starting subtest: u-submit-golden-slice
[584.411849] Starting dynamic subtest: rcs0
[584.434075] Dynamic subtest rcs0: SUCCESS (0.033s)
[584.444233] Starting dynamic subtest: bcs0
[584.475419] Dynamic subtest bcs0: SUCCESS (0.041s)
[584.485220] Starting dynamic subtest: vcs0
[584.515319] Dynamic subtest vcs0: SUCCESS (0.038s)
[584.528312] Starting dynamic subtest: vcs1
[584.567892] Dynamic subtest vcs1: SUCCESS (0.052s)
[584.579868] Starting dynamic subtest: vecs0
[584.601614] Dynamic subtest vecs0: SUCCESS (0.033s)
[584.611391] Starting dynamic subtest: ccs0
[584.642604] Dynamic subtest ccs0: SUCCESS (0.040s)
[584.644943] Subtest u-submit-golden-slice: SUCCESS (0.242s)
[585.947646] [125/133] (444s left) gem_readwrite (new-obj)
[586.013136] Subtest new-obj: SKIP (0.000s)
[586.077633] [126/133] (444s left) gem_exec_reloc (basic-write-wc-noreloc)
[586.144153] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[586.222239] [127/133] (444s left) kms_fb_coherency (memset-crc)
[586.307763] Starting subtest: memset-crc
[586.310094] Starting dynamic subtest: mmap-offset-wc
[586.674067] Dynamic subtest mmap-offset-wc: SUCCESS (0.365s)
[586.965272] Starting dynamic subtest: mmap-offset-uc
[593.009550] Dynamic subtest mmap-offset-uc: SUCCESS (6.057s)
[593.296477] Subtest memset-crc: SUCCESS (6.988s)
[594.092888] [128/133] (436s left) gem_softpin (allocator-nopin)
[594.152374] Starting subtest: allocator-nopin
[594.257781] Subtest allocator-nopin: SUCCESS (0.104s)
[594.403461] [129/133] (436s left) gem_flink_basic (flink-lifetime)
[594.465842] Starting subtest: flink-lifetime
[594.468098] Subtest flink-lifetime: SUCCESS (0.002s)
[594.563598] [130/133] (436s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[594.657874] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[594.748190] [131/133] (436s left) gen9_exec_parse (bb-secure)
[594.802481] Subtest bb-secure: SKIP (0.000s)
[594.866436] [132/133] (436s left) kms_addfb_basic (invalid-set-prop-any)
[594.923838] Starting subtest: invalid-set-prop-any
[594.925769] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[595.054377] [133/133] (436s left) gem_exec_reloc (basic-wc-read)
[595.105189] Subtest basic-wc-read: SKIP (0.000s)
[595.171561] Closing watchdogs
results: parsing output: 0/ for test: prime_mmap
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_create
results: parsing output: 3/ for test: api_intel_bb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: kms_cursor_edge_walk
results: parsing output: 7/ for test: i915_suspend
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: sriov_basic
results: parsing output: 10/ for test: kms_plane_alpha_blend
results: parsing output: 11/ for test: kms_joiner
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: i915_module_load
results: parsing output: 16/ for test: kms_chamelium_frames
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_ctx_create
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: gem_softpin
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_dp_link_training
results: parsing output: 44/ for test: gem_ctx_isolation
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: dumb_buffer
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_selftest
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_content_protection
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_tv_load_detect
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gem_ppgtt
results: parsing output: 63/ for test: i915_pm_rpm
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_cdclk
results: parsing output: 68/ for test: gem_partial_pwrite_pread
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: gem_exercise_blt
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: gem_pread
results: parsing output: 76/ for test: kms_busy
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: gen3_render_linear_blits
results: parsing output: 81/ for test: kms_joiner
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: gem_pxp
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: gem_ctx_sseu
results: parsing output: 93/ for test: gem_wait
results: parsing output: 94/ for test: gem_mmap_offset
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: fbdev
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_vblank
results: parsing output: 101/ for test: kms_color
results: parsing output: 102/ for test: gem_flink_race
results: parsing output: 103/ for test: gem_ctx_param
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_plane_multiple
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_exec_flush
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: api_intel_allocator
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: i915_drm_fdinfo
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_softpin
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: gem_readwrite
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_fb_coherency
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: gem_flink_basic
results: parsing output: 129/ for test: kms_addfb_basic
results: parsing output: 130/ for test: gen9_exec_parse
results: parsing output: 131/ for test: kms_addfb_basic
results: parsing output: 132/ for test: gem_exec_reloc
Done.