[57.976456] Initializing watchdogs [57.976499] /dev/watchdog0 [57.990554] [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] [57.994921] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.997069] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.000364] [001/133] (960s left) kms_cursor_crc (cursor-onscreen-32x10) [58.189544] Starting subtest: cursor-onscreen-32x10 [58.243626] Subtest cursor-onscreen-32x10: SKIP (0.048s) [58.479675] [002/133] (960s left) gem_basic (multigpu-create-close) [58.528835] Starting subtest: multigpu-create-close [58.533714] Subtest multigpu-create-close: SKIP (0.000s) [58.632556] [003/133] (959s left) gem_mmap (bad-size) [58.686515] Subtest bad-size: SKIP (0.000s) [58.749172] [004/133] (959s left) perf_pmu (interrupts) [58.788811] Starting subtest: interrupts [59.889665] Subtest interrupts: SUCCESS (1.097s) [59.991297] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true [59.994690] [005/133] (958s left) kms_selftest (drm_cmdline_parser) [60.034133] Starting subtest: drm_cmdline_parser [60.044813] Starting dynamic subtest: drm_test_cmdline_force_d_only [60.152051] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.107s) [60.159290] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [60.261686] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.109s) [60.269110] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [60.351255] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.089s) [60.360580] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [60.439242] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.087s) [60.448276] Starting dynamic subtest: drm_test_cmdline_force_e_only [60.560992] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.120s) [60.569696] Starting dynamic subtest: drm_test_cmdline_res [60.656758] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.096s) [60.664923] Starting dynamic subtest: drm_test_cmdline_res_vesa [60.751490] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.094s) [60.760222] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [60.832402] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.081s) [60.841511] Starting dynamic subtest: drm_test_cmdline_res_rblank [60.922242] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.088s) [60.931162] Starting dynamic subtest: drm_test_cmdline_res_bpp [61.025462] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.103s) [61.034630] Starting dynamic subtest: drm_test_cmdline_res_refresh [61.121721] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.097s) [61.130926] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [61.208375] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.086s) [61.217532] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [61.304594] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.097s) [61.313178] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [61.390508] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.085s) [61.399145] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [61.479372] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.088s) [61.488351] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [61.577958] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.099s) [61.587037] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [61.662406] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.084s) [61.671263] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [61.753973] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.091s) [61.762798] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [61.843922] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.089s) [61.852717] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [61.930027] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.084s) [61.938637] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [62.011570] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.084s) [62.020342] Starting dynamic subtest: drm_test_cmdline_name [62.109857] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.097s) [62.118124] Starting dynamic subtest: drm_test_cmdline_name_bpp [62.200958] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.091s) [62.209719] Starting dynamic subtest: drm_test_cmdline_name_option [62.292708] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.091s) [62.301277] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [62.387660] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.095s) [62.395145] Starting dynamic subtest: drm_test_cmdline_rotate_0 [62.477562] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.090s) [62.486184] Starting dynamic subtest: drm_test_cmdline_rotate_90 [62.575193] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.097s) [62.582422] Starting dynamic subtest: drm_test_cmdline_rotate_180 [62.660436] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.082s) [62.669117] Starting dynamic subtest: drm_test_cmdline_rotate_270 [62.750708] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.092s) [62.759413] Starting dynamic subtest: drm_test_cmdline_hmirror [62.843854] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.093s) [62.850882] Starting dynamic subtest: drm_test_cmdline_vmirror [62.925385] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.081s) [62.932145] Starting dynamic subtest: drm_test_cmdline_margin_options [63.028402] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.103s) [63.035479] Starting dynamic subtest: drm_test_cmdline_multiple_options [63.124739] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.095s) [63.134261] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [63.214716] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.089s) [63.221183] Starting dynamic subtest: drm_test_cmdline_extra_and_option [63.302656] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.087s) [63.311488] Starting dynamic subtest: drm_test_cmdline_freestanding_options [63.395979] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.093s) [63.404888] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [63.489905] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.093s) [63.498397] Starting dynamic subtest: drm_test_cmdline_panel_orientation [63.593744] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.104s) [63.602164] Starting dynamic subtest: drm_test_cmdline_invalid [63.698288] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.105s) [63.706414] Starting dynamic subtest: drm_test_cmdline_tv_options [63.789745] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.089s) [63.791354] Subtest drm_cmdline_parser: SUCCESS (3.749s) [63.956890] [006/133] (954s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [64.048411] Starting subtest: extended-pageflip-modeset-hang-oldfb [64.050291] Starting dynamic subtest: pipe-A [71.990523] Dynamic subtest pipe-A: SUCCESS (7.936s) [71.998265] Starting dynamic subtest: pipe-D [80.571527] Dynamic subtest pipe-D: SUCCESS (8.575s) [80.574060] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.516s) [81.432218] [007/133] (937s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [81.559195] Starting subtest: flip-vs-cursor-busy-crc-atomic [82.374749] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.814s) [83.180738] [008/133] (935s left) vgem_basic (dmabuf-mmap) [83.228101] Starting subtest: dmabuf-mmap [83.238066] Subtest dmabuf-mmap: SUCCESS (0.010s) [83.296418] [009/133] (935s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [83.416083] Starting subtest: cursorB-vs-flipA-toggle [83.420719] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s) [83.559404] [010/133] (935s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [83.618657] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [83.622477] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [83.800884] [011/133] (935s left) gem_exec_endless (dispatch) [83.873638] Starting subtest: dispatch [83.876043] Starting dynamic subtest: rcs0 [83.880722] Dynamic subtest rcs0: SUCCESS (0.005s) [83.892423] Starting dynamic subtest: bcs0 [83.896673] Dynamic subtest bcs0: SUCCESS (0.004s) [83.904905] Starting dynamic subtest: vcs0 [83.909432] Dynamic subtest vcs0: SUCCESS (0.005s) [83.917890] Starting dynamic subtest: vcs1 [83.921914] Dynamic subtest vcs1: SUCCESS (0.010s) [83.928802] Starting dynamic subtest: vecs0 [83.935331] Dynamic subtest vecs0: SUCCESS (0.006s) [83.943110] Starting dynamic subtest: ccs0 [83.947395] Dynamic subtest ccs0: SUCCESS (0.005s) [83.949322] Subtest dispatch: SUCCESS (0.036s) [85.953328] [012/133] (932s left) kms_pm_rpm (package-g7) [88.093188] Starting subtest: package-g7 [88.098694] Subtest package-g7: SKIP (0.000s) [88.485173] [013/133] (930s left) i915_pm_rpm (gem-idle) [90.009468] Starting subtest: gem-idle [96.213926] Subtest gem-idle: SUCCESS (6.203s) [96.541111] [014/133] (922s left) kms_invalid_mode (uint-max-clock) [97.885413] Starting subtest: uint-max-clock [97.887789] Starting dynamic subtest: pipe-A-eDP-1 [98.180576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s) [98.190469] Starting dynamic subtest: pipe-B-eDP-1 [98.192358] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [98.199151] Starting dynamic subtest: pipe-C-eDP-1 [98.201032] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [98.208202] Starting dynamic subtest: pipe-D-eDP-1 [98.210427] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [98.212764] Subtest uint-max-clock: SUCCESS (0.300s) [98.991894] [015/133] (920s left) kms_color_pipeline (plane-lut1d-post-ctm3x4) [99.086067] Starting subtest: plane-lut1d-post-ctm3x4 [99.235739] Starting dynamic subtest: pipe-A-plane-0 [99.402342] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s) [99.412067] Starting dynamic subtest: pipe-A-plane-1 [99.536077] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [99.544159] Starting dynamic subtest: pipe-A-plane-2 [99.669338] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s) [100.866154] Starting dynamic subtest: pipe-B-plane-0 [101.014711] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s) [101.023412] Starting dynamic subtest: pipe-B-plane-1 [101.159277] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s) [101.167456] Starting dynamic subtest: pipe-B-plane-2 [101.292463] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [102.516647] Starting dynamic subtest: pipe-C-plane-0 [102.644466] Dynamic subtest pipe-C-plane-0: SUCCESS (0.134s) [102.654881] Starting dynamic subtest: pipe-C-plane-1 [102.799748] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [102.808720] Starting dynamic subtest: pipe-C-plane-2 [102.999978] Dynamic subtest pipe-C-plane-2: SUCCESS (0.200s) [104.234501] Starting dynamic subtest: pipe-D-plane-0 [104.371634] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [104.379734] Starting dynamic subtest: pipe-D-plane-1 [104.504754] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [104.513297] Starting dynamic subtest: pipe-D-plane-2 [104.649577] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [104.935564] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.848s) [105.805537] [016/133] (913s left) gem_lmem_swapping (heavy-verify-random-ccs) [105.865776] Subtest heavy-verify-random-ccs: SKIP (0.000s) [105.912407] [017/133] (913s left) i915_query (query-topology-kernel-writes) [105.966727] Starting subtest: query-topology-kernel-writes [105.968849] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [106.054283] [018/133] (913s left) prime_vgem (coherency-gtt) [106.129988] Starting subtest: coherency-gtt [106.134478] Subtest coherency-gtt: SKIP (0.000s) [106.228038] [019/133] (913s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [106.326297] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [110.343683] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.021s) [111.512826] [020/133] (907s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [111.580614] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [111.691357] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.109s) [111.769329] [021/133] (907s left) kms_flip (plain-flip-fb-recreate) [111.869048] Starting subtest: plain-flip-fb-recreate [111.871514] Starting dynamic subtest: A-eDP1 [120.700350] Dynamic subtest A-eDP1: SUCCESS (8.831s) [120.707990] Starting dynamic subtest: B-eDP1 [129.539310] Dynamic subtest B-eDP1: SUCCESS (8.837s) [129.548408] Starting dynamic subtest: C-eDP1 [138.366129] Dynamic subtest C-eDP1: SUCCESS (8.826s) [138.377354] Starting dynamic subtest: D-eDP1 [147.197658] Dynamic subtest D-eDP1: SUCCESS (8.830s) [147.199753] Subtest plain-flip-fb-recreate: SUCCESS (35.332s) [148.384536] [022/133] (870s left) kms_cursor_legacy (forked-bo) [148.513343] Starting subtest: forked-bo [148.515314] Starting dynamic subtest: pipe-A [154.007753] Dynamic subtest pipe-A: SUCCESS (5.490s) [154.022059] Starting dynamic subtest: pipe-B [159.475697] Dynamic subtest pipe-B: SUCCESS (5.467s) [159.488816] Starting dynamic subtest: pipe-C [164.961997] Dynamic subtest pipe-C: SUCCESS (5.482s) [164.972436] Starting dynamic subtest: pipe-D [170.441911] Dynamic subtest pipe-D: SUCCESS (5.480s) [170.452239] Starting dynamic subtest: all-pipes [175.928932] Dynamic subtest all-pipes: SUCCESS (5.485s) [175.931723] Subtest forked-bo: SUCCESS (27.412s) [176.072273] [023/133] (843s left) gen9_exec_parse (basic-rejected-ctx-param) [176.143757] Subtest basic-rejected-ctx-param: SKIP (0.000s) [176.205905] [024/133] (843s left) kms_psr (psr-cursor-plane-onoff) [176.292088] Starting subtest: psr-cursor-plane-onoff [176.294438] Starting dynamic subtest: eDP-1 [177.983212] Dynamic subtest eDP-1: SUCCESS (1.690s) [177.985516] Subtest psr-cursor-plane-onoff: SUCCESS (1.691s) [178.841857] [025/133] (840s left) gem_create (busy-create) [178.891344] Starting subtest: busy-create [178.893668] Starting dynamic subtest: smem0 [212.886312] Dynamic subtest smem0: SUCCESS (33.992s) [212.888937] Subtest busy-create: SUCCESS (33.993s) [213.070073] [026/133] (806s left) kms_psr (psr-suspend) [213.171934] Starting subtest: psr-suspend [213.174305] Starting dynamic subtest: eDP-1 [230.670541] Dynamic subtest eDP-1: SUCCESS (3.804s) [230.672974] Subtest psr-suspend: SUCCESS (3.804s) [231.537777] [027/133] (788s left) gem_exec_reloc (basic-gtt-read-active) [231.619559] Subtest basic-gtt-read-active: SKIP (0.000s) [231.693150] [028/133] (787s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [231.784454] Starting subtest: yf-tiled-64bpp-rotate-270 [231.788840] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [231.871268] [029/133] (787s left) i915_module_load (reload) [231.907800] Starting subtest: reload [236.718966] Subtest reload: SUCCESS (4.776s) [236.778424] [030/133] (782s left) perf_pmu (invalid-open) [236.832646] Starting subtest: invalid-open [236.834944] Subtest invalid-open: SUCCESS (0.000s) [238.602046] [031/133] (781s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [238.704406] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [238.708655] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [238.791446] [032/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [238.896650] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [245.469915] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.558s) [245.589634] [033/133] (774s left) gem_render_copy (yf-tiled) [245.652970] Starting subtest: yf-tiled [245.657119] Subtest yf-tiled: SKIP (0.000s) [245.835856] [034/133] (774s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [245.930153] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [245.934704] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [246.000273] [035/133] (773s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [246.087800] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [246.090061] Starting dynamic subtest: pipe-A-eDP-1 [246.113168] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [246.126738] Starting dynamic subtest: pipe-B-eDP-1 [246.149128] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [246.156857] Starting dynamic subtest: pipe-C-eDP-1 [246.178876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [246.186924] Starting dynamic subtest: pipe-D-eDP-1 [246.209741] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [246.214511] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [248.349987] [036/133] (771s left) kms_cursor_crc (cursor-random-256x256) [248.586834] Starting subtest: cursor-random-256x256 [248.592036] Starting dynamic subtest: pipe-A-eDP-1 [251.912948] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.319s) [251.943175] Starting dynamic subtest: pipe-D-eDP-1 [255.951791] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.011s) [255.954010] Subtest cursor-random-256x256: SUCCESS (7.355s) [256.808763] [037/133] (763s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [256.904554] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [256.908581] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [257.010823] [038/133] (763s left) gem_pwrite (basic-self) [257.074610] Subtest basic-self: SKIP (0.000s) [257.130403] [039/133] (762s left) gem_mmap_gtt (big-copy-xy) [257.184843] Subtest big-copy-XY: SKIP (0.000s) [257.268837] [040/133] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [257.357729] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [264.234325] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.876s) [264.406557] [041/133] (755s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [264.502090] Starting subtest: plane-downscale-factor-0-5-with-modifiers [264.504385] Starting dynamic subtest: pipe-A [264.525112] Dynamic subtest pipe-A: SKIP (0.016s) [264.534055] Starting dynamic subtest: pipe-B [264.559272] Dynamic subtest pipe-B: SKIP (0.034s) [264.570546] Starting dynamic subtest: pipe-C [264.590838] Dynamic subtest pipe-C: SKIP (0.033s) [264.599284] Starting dynamic subtest: pipe-D [264.622218] Dynamic subtest pipe-D: SKIP (0.029s) [264.626692] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.114s) [264.737691] [042/133] (755s left) gem_exec_schedule (preempt-other) [264.821783] Starting subtest: preempt-other [264.824048] Starting dynamic subtest: rcs0 [264.887063] Dynamic subtest rcs0: SUCCESS (0.076s) [264.897577] Starting dynamic subtest: bcs0 [264.951601] Dynamic subtest bcs0: SUCCESS (0.064s) [264.962220] Starting dynamic subtest: vcs0 [265.021119] Dynamic subtest vcs0: SUCCESS (0.069s) [265.034598] Starting dynamic subtest: vcs1 [265.085446] Dynamic subtest vcs1: SUCCESS (0.064s) [265.095212] Starting dynamic subtest: vecs0 [265.156064] Dynamic subtest vecs0: SUCCESS (0.070s) [265.165492] Starting dynamic subtest: ccs0 [265.224110] Dynamic subtest ccs0: SUCCESS (0.066s) [265.226957] Subtest preempt-other: SUCCESS (0.413s) [266.666508] [043/133] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [266.770710] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [266.775153] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [266.870465] [044/133] (753s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [266.967504] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [266.971589] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [267.055152] [045/133] (753s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [267.151754] Starting subtest: fbcpsr-rgb565-draw-pwrite [274.118845] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.969s) [274.242126] [046/133] (746s left) kms_big_fb (linear-addfb) [274.340275] Starting subtest: linear-addfb [274.342463] Subtest linear-addfb: SUCCESS (0.000s) [274.429147] [047/133] (746s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [274.549612] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [275.550982] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.001s) [275.667744] [048/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [275.759021] Starting subtest: fbcpsr-2p-rte [275.762828] Subtest fbcpsr-2p-rte: SKIP (0.000s) [275.840345] [049/133] (744s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [275.927171] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [275.938469] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s) [276.015024] [050/133] (744s left) gem_ctx_param (invalid-size-get) [276.073514] Starting subtest: invalid-size-get [276.075638] Subtest invalid-size-get: SUCCESS (0.001s) [276.187614] [051/133] (744s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [276.299152] Starting subtest: psr2-primary-plane-update-sf-dmg-area [276.301175] Starting dynamic subtest: pipe-A-eDP-1 [282.159069] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.858s) [282.172672] Starting dynamic subtest: pipe-B-eDP-1 [288.812304] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.652s) [288.814724] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.513s) [289.680031] [052/133] (730s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [289.738388] Starting subtest: multi-wait-for-submit-available-submitted [289.740341] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [289.826863] [053/133] (730s left) perf_pmu (busy-accuracy-98) [289.870474] Starting subtest: busy-accuracy-98 [289.872722] Starting dynamic subtest: rcs0 [292.911347] Dynamic subtest rcs0: SUCCESS (3.036s) [292.920258] Starting dynamic subtest: bcs0 [295.960582] Dynamic subtest bcs0: SUCCESS (3.045s) [295.970449] Starting dynamic subtest: vcs0 [299.006365] Dynamic subtest vcs0: SUCCESS (3.042s) [299.017179] Starting dynamic subtest: vcs1 [302.052164] Dynamic subtest vcs1: SUCCESS (3.042s) [302.061186] Starting dynamic subtest: vecs0 [305.099310] Dynamic subtest vecs0: SUCCESS (3.043s) [305.108325] Starting dynamic subtest: ccs0 [308.154254] Dynamic subtest ccs0: SUCCESS (3.050s) [308.156914] Subtest busy-accuracy-98: SUCCESS (18.274s) [308.287532] [054/133] (712s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [308.394126] Starting subtest: psr-farfromfence-mmap-gtt [308.398416] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [308.491967] [055/133] (712s left) gem_exec_params (no-vebox) [308.550853] Starting subtest: no-vebox [308.556015] Subtest no-vebox: SUCCESS (0.003s) [310.722797] [056/133] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [310.815585] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [318.127536] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.311s) [318.245362] [057/133] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [318.350611] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [325.532922] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.182s) [325.654926] [058/133] (695s left) gem_exec_fence (syncobj-timeline-signal) [326.198242] Starting subtest: syncobj-timeline-signal [326.205080] Subtest syncobj-timeline-signal: SUCCESS (0.008s) [327.713546] [059/133] (693s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [327.810515] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [327.814866] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [327.907647] [060/133] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [328.009676] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [328.014077] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [328.122576] [061/133] (692s left) perf (missing-sample-flags) [328.248953] Starting subtest: missing-sample-flags [328.250872] Subtest missing-sample-flags: SUCCESS (0.000s) [328.294154] [062/133] (692s left) kms_chamelium_edid (hdmi-edid-read) [328.677767] Subtest hdmi-edid-read: SKIP (0.000s) [329.456158] [063/133] (691s left) kms_dsc (dsc-basic) [329.550948] Starting subtest: dsc-basic [329.564372] Subtest dsc-basic: SKIP (0.000s) [329.626628] [064/133] (691s left) kms_cursor_edge_walk (64x64-top-edge) [329.733486] Starting subtest: 64x64-top-edge [329.735630] Starting dynamic subtest: pipe-A-eDP-1 [333.248349] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.516s) [333.258459] Starting dynamic subtest: pipe-D-eDP-1 [336.381305] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s) [336.383695] Subtest 64x64-top-edge: SUCCESS (6.654s) [337.192590] [065/133] (684s left) kms_content_protection (legacy) [337.333684] Starting subtest: legacy [337.338161] Subtest legacy: SKIP (0.000s) [337.448427] [066/133] (683s left) kms_psr (fbc-psr2-sprite-plane-move) [337.536030] Starting subtest: fbc-psr2-sprite-plane-move [337.538292] Starting dynamic subtest: eDP-1 [337.542409] Dynamic subtest eDP-1: SKIP (0.000s) [337.546567] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [337.620519] [067/133] (683s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [337.702990] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [337.707032] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [337.774934] [068/133] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [337.862233] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [337.866560] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [337.945167] [069/133] (683s left) kms_flip (2x-plain-flip-interruptible) [338.025349] Starting subtest: 2x-plain-flip-interruptible [338.036367] Subtest 2x-plain-flip-interruptible: SKIP (0.010s) [338.115171] [070/133] (683s left) kms_psr (pr-primary-mmap-gtt) [338.206418] Starting subtest: pr-primary-mmap-gtt [338.210177] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [338.281743] [071/133] (683s left) kms_flip (2x-busy-flip) [338.380456] Starting subtest: 2x-busy-flip [338.388460] Subtest 2x-busy-flip: SKIP (0.010s) [338.508175] [072/133] (683s left) kms_atomic (plane-immutable-zpos) [338.593444] Starting subtest: plane-immutable-zpos [338.595113] Starting dynamic subtest: pipe-A-eDP-1 [339.226816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s) [339.229428] Subtest plane-immutable-zpos: SUCCESS (0.634s) [340.018049] [073/133] (681s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [340.126184] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [340.131896] Starting dynamic subtest: pipe-A-eDP-1 [340.190089] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [340.198501] Starting dynamic subtest: pipe-B-eDP-1 [340.252724] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [340.261536] Starting dynamic subtest: pipe-C-eDP-1 [340.316009] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [340.324691] Starting dynamic subtest: pipe-D-eDP-1 [340.379587] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [340.383663] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s) [342.392603] [074/133] (679s left) kms_chamelium_hpd (vga-hpd-fast) [342.775910] Subtest vga-hpd-fast: SKIP (0.000s) [343.588293] [075/133] (678s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [343.676539] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [347.296639] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.624s) [348.427663] [076/133] (673s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [348.517175] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [354.767626] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.254s) [355.914896] [077/133] (665s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [356.019822] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [356.024554] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [357.136604] [078/133] (664s left) syncobj_timeline (wait-all-complex) [357.195042] Starting subtest: wait-all-complex [357.407814] Subtest wait-all-complex: SUCCESS (0.212s) [357.495068] [079/133] (664s left) kms_big_fb (y-tiled-64bpp-rotate-270) [357.590535] Starting subtest: y-tiled-64bpp-rotate-270 [357.594747] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [357.691654] [080/133] (664s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [357.754839] Starting subtest: multi-wait-all-for-submit-unsubmitted [357.864655] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [357.962018] [081/133] (663s left) gem_mmap_gtt (medium-copy-odd) [358.030204] Subtest medium-copy-odd: SKIP (0.000s) [358.097489] [082/133] (663s left) gem_exec_fence (basic-wait-all) [358.160270] Starting subtest: basic-wait-all [358.250502] Subtest basic-wait-all: SUCCESS (0.092s) [359.645483] [083/133] (662s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [359.753156] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [359.755460] Starting dynamic subtest: pipe-A-default-mode [362.460520] Dynamic subtest pipe-A-default-mode: SUCCESS (2.708s) [362.462932] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.709s) [363.323833] [084/133] (658s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [363.383451] Starting subtest: multi-wait-for-submit-unsubmitted [363.489277] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s) [363.571147] [085/133] (658s left) kms_vblank (ts-continuation-suspend) [363.666052] Starting subtest: ts-continuation-suspend [363.668232] Starting dynamic subtest: pipe-A-eDP-1 [380.511346] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.527s) [380.525698] Starting dynamic subtest: pipe-D-eDP-1 [397.546047] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.209s) [397.548663] Subtest ts-continuation-suspend: SUCCESS (3.740s) [398.354734] [086/133] (623s left) core_getversion (basic) [398.402880] Starting subtest: basic [398.406988] Subtest basic: SUCCESS (0.000s) [398.474514] [087/133] (623s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [398.560819] Starting subtest: fbc-rgb565-draw-blt [402.752946] Subtest fbc-rgb565-draw-blt: SUCCESS (4.158s) [403.903475] [088/133] (618s left) kms_big_fb (x-tiled-32bpp-rotate-90) [404.017598] Starting subtest: x-tiled-32bpp-rotate-90 [404.037356] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s) [404.150070] [089/133] (618s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [404.214332] Starting subtest: etime-multi-wait-for-submit-submitted [404.321196] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s) [404.410635] [090/133] (617s left) template (a) [404.462657] Starting subtest: A [404.464981] Subtest A: SUCCESS (0.000s) [404.578522] [091/133] (617s left) gem_partial_pwrite_pread (write-snoop) [404.639120] Subtest write-snoop: SKIP (0.000s) [404.712529] [092/133] (617s left) i915_drm_fdinfo (busy-hang) [404.756880] Starting subtest: busy-hang [404.758818] Starting dynamic subtest: rcs0 [404.794247] Dynamic subtest rcs0: SKIP (0.037s) [404.805247] Starting dynamic subtest: bcs0 [404.809378] Dynamic subtest bcs0: SKIP (0.001s) [404.817922] Starting dynamic subtest: vcs0 [404.822380] Dynamic subtest vcs0: SKIP (0.000s) [404.830864] Starting dynamic subtest: vcs1 [404.835187] Dynamic subtest vcs1: SKIP (0.001s) [404.843301] Starting dynamic subtest: vecs0 [404.847417] Dynamic subtest vecs0: SKIP (0.000s) [404.855529] Starting dynamic subtest: ccs0 [404.859594] Dynamic subtest ccs0: SKIP (0.000s) [404.863630] Subtest busy-hang: SKIP (0.044s) [404.901530] [093/133] (617s left) gem_exec_fence (keep-in-fence) [405.073423] Starting subtest: keep-in-fence [405.075894] Starting dynamic subtest: rcs0 [405.127948] Dynamic subtest rcs0: SUCCESS (0.054s) [405.139470] Starting dynamic subtest: bcs0 [405.180903] Dynamic subtest bcs0: SUCCESS (0.051s) [405.192105] Starting dynamic subtest: vcs0 [406.715615] Dynamic subtest vcs0: SUCCESS (1.525s) [406.727966] Starting dynamic subtest: vcs1 [408.700572] Dynamic subtest vcs1: SUCCESS (1.975s) [408.712364] Starting dynamic subtest: vecs0 [410.748825] Dynamic subtest vecs0: SUCCESS (2.040s) [410.761103] Starting dynamic subtest: ccs0 [411.010105] Dynamic subtest ccs0: SUCCESS (0.259s) [411.012967] Subtest keep-in-fence: SUCCESS (5.917s) [412.794660] [094/133] (609s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [412.909674] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [412.912017] Starting dynamic subtest: pipe-A-eDP-1 [415.161537] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.249s) [415.170492] Starting dynamic subtest: pipe-B-eDP-1 [417.374983] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.208s) [417.384147] Starting dynamic subtest: pipe-C-eDP-1 [419.418133] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.041s) [419.428088] Starting dynamic subtest: pipe-D-eDP-1 [421.511387] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.089s) [421.513304] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.592s) [422.673663] [095/133] (599s left) syncobj_timeline (multi-wait-all-available-submitted) [422.731697] Starting subtest: multi-wait-all-available-submitted [422.734151] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s) [422.848960] [096/133] (599s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [422.938217] Starting subtest: 2x-flip-vs-absolute-wf_vblank [422.946778] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s) [423.041877] [097/133] (599s left) kms_pm_backlight (basic-brightness) [423.137025] Starting subtest: basic-brightness [423.189273] Starting dynamic subtest: eDP-1 [423.500913] Dynamic subtest eDP-1: SUCCESS (0.309s) [423.503196] Subtest basic-brightness: SUCCESS (0.363s) [424.301373] [098/133] (598s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [424.413382] Starting subtest: 2x-long-cursor-vs-flip-legacy [424.417730] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [424.562237] [099/133] (598s left) kms_plane (pixel-format-yf-tiled-modifier) [424.664272] Starting subtest: pixel-format-yf-tiled-modifier [424.668487] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s) [424.749155] [100/133] (597s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [424.842759] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [425.866863] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.023s) [425.979538] [101/133] (596s left) kms_plane_alpha_blend (alpha-7efc) [426.065759] Starting subtest: alpha-7efc [426.348263] Starting dynamic subtest: pipe-A-eDP-1 [426.936761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s) [426.961930] Starting dynamic subtest: pipe-D-eDP-1 [428.215032] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s) [428.217429] Subtest alpha-7efc: SUCCESS (2.148s) [429.062516] [102/133] (593s left) kms_atomic_transition (plane-all-transition-nonblocking) [429.157585] Starting subtest: plane-all-transition-nonblocking [429.159832] Starting dynamic subtest: pipe-A-eDP-1 [431.649295] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [431.957424] Starting dynamic subtest: pipe-B-eDP-1 [435.181392] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.235s) [435.493975] Subtest plane-all-transition-nonblocking: SUCCESS (6.341s) [436.312386] [103/133] (586s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [436.407572] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [436.411740] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [436.500898] [104/133] (586s left) gem_exec_store (cachelines) [436.567815] Starting subtest: cachelines [436.569699] Starting dynamic subtest: rcs0 [436.631359] Dynamic subtest rcs0: SUCCESS (0.065s) [436.642801] Starting dynamic subtest: bcs0 [436.679761] Dynamic subtest bcs0: SUCCESS (0.047s) [436.689977] Starting dynamic subtest: vcs0 [436.733010] Dynamic subtest vcs0: SUCCESS (0.052s) [436.743680] Starting dynamic subtest: vcs1 [436.786639] Dynamic subtest vcs1: SUCCESS (0.052s) [436.797473] Starting dynamic subtest: vecs0 [436.844249] Dynamic subtest vecs0: SUCCESS (0.056s) [436.854934] Starting dynamic subtest: ccs0 [436.898091] Dynamic subtest ccs0: SUCCESS (0.052s) [436.900684] Subtest cachelines: SUCCESS (0.333s) [437.082767] [105/133] (585s left) gem_ctx_persistence (hang) [437.135272] Starting subtest: hang [437.139643] Subtest hang: SKIP (0.000s) [437.231654] [106/133] (585s left) api_intel_allocator (reserve-simple) [437.276742] Starting subtest: reserve-simple [437.279038] Subtest reserve-simple: SUCCESS (0.003s) [437.386807] [107/133] (585s left) syncobj_wait (signal) [437.432795] Starting subtest: signal [437.434898] Subtest signal: SUCCESS (0.000s) [437.524628] [108/133] (585s left) i915_pm_rps (thresholds-idle) [437.578543] Starting subtest: thresholds-idle [437.583006] Subtest thresholds-idle: SKIP (0.001s) [437.653042] [109/133] (585s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [437.747253] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [437.749433] Starting dynamic subtest: pipe-A-eDP-1 [437.843317] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [437.852535] Starting dynamic subtest: pipe-B-eDP-1 [438.986418] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s) [438.990795] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.242s) [440.169108] [110/133] (582s left) kms_lease (lease-uevent) [440.255294] Starting subtest: lease-uevent [441.270005] Subtest lease-uevent: SUCCESS (1.016s) [441.381141] [111/133] (581s left) kms_addfb_basic (master-rmfb) [441.446976] Starting subtest: master-rmfb [441.449282] Subtest master-rmfb: SUCCESS (0.001s) [441.579232] [112/133] (581s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [441.684541] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [441.688769] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [441.798566] [113/133] (581s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [441.878433] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [441.880594] Starting dynamic subtest: pipe-A-eDP-1 [441.902671] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [441.915032] Starting dynamic subtest: pipe-B-eDP-1 [441.935224] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [441.944124] Starting dynamic subtest: pipe-C-eDP-1 [441.964584] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [441.973081] Starting dynamic subtest: pipe-D-eDP-1 [441.993852] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [441.997744] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s) [444.123989] [114/133] (579s left) gem_ctx_persistence (engines-hang) [444.178448] Starting subtest: engines-hang [444.180871] Starting dynamic subtest: rcs0 [444.261752] Dynamic subtest rcs0: SUCCESS (0.083s) [444.273513] Starting dynamic subtest: bcs0 [444.360927] Dynamic subtest bcs0: SUCCESS (0.097s) [444.373353] Starting dynamic subtest: vcs0 [444.448868] Dynamic subtest vcs0: SUCCESS (0.085s) [444.461365] Starting dynamic subtest: vcs1 [444.544833] Dynamic subtest vcs1: SUCCESS (0.094s) [444.556327] Starting dynamic subtest: vecs0 [444.625873] Dynamic subtest vecs0: SUCCESS (0.079s) [444.636862] Starting dynamic subtest: ccs0 [444.750730] Dynamic subtest ccs0: SUCCESS (0.123s) [444.753224] Subtest engines-hang: SUCCESS (0.574s) [444.846962] [115/133] (578s left) syncobj_basic (create-signaled) [444.902447] Starting subtest: create-signaled [444.904575] Subtest create-signaled: SUCCESS (0.000s) [444.999376] [116/133] (578s left) gem_ctx_shared (disjoint-timelines) [445.073311] Starting subtest: disjoint-timelines [445.092658] Subtest disjoint-timelines: SUCCESS (0.019s) [445.332716] [117/133] (578s left) gem_mmap_offset (oob-read) [445.383969] Starting subtest: oob-read [445.386201] Subtest oob-read: SUCCESS (0.000s) [445.475882] [118/133] (577s left) sysfs_timeslice_duration (invalid) [445.530777] Starting subtest: invalid [445.533091] Starting dynamic subtest: vecs0 [445.535464] Dynamic subtest vecs0: SUCCESS (0.000s) [445.546104] Starting dynamic subtest: ccs0 [445.548300] Dynamic subtest ccs0: SUCCESS (0.000s) [445.556943] Starting dynamic subtest: vcs0 [445.559044] Dynamic subtest vcs0: SUCCESS (0.000s) [445.567637] Starting dynamic subtest: bcs0 [445.569522] Dynamic subtest bcs0: SUCCESS (0.000s) [445.577759] Starting dynamic subtest: rcs0 [445.579619] Dynamic subtest rcs0: SUCCESS (0.000s) [445.587795] Starting dynamic subtest: vcs1 [445.589667] Dynamic subtest vcs1: SUCCESS (0.000s) [445.591510] Subtest invalid: SUCCESS (0.006s) [445.628625] [119/133] (577s left) gem_readwrite (read-write) [445.678718] Subtest read-write: SKIP (0.000s) [445.737818] [120/133] (577s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [445.800129] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [445.875422] [121/133] (577s left) prime_busy (hang-wait) [445.934228] Starting subtest: hang-wait [445.936543] Starting dynamic subtest: rcs0 [472.219233] Dynamic subtest rcs0: SUCCESS (26.278s) [472.227982] Starting dynamic subtest: bcs0 [479.307421] Dynamic subtest bcs0: SUCCESS (7.083s) [479.316237] Starting dynamic subtest: vcs0 [486.343272] Dynamic subtest vcs0: SUCCESS (7.032s) [486.355037] Starting dynamic subtest: vcs1 [493.325235] Dynamic subtest vcs1: SUCCESS (6.976s) [493.336211] Starting dynamic subtest: vecs0 [500.296956] Dynamic subtest vecs0: SUCCESS (6.972s) [500.308056] Starting dynamic subtest: ccs0 [514.197388] Dynamic subtest ccs0: SUCCESS (13.901s) [514.199687] Subtest hang-wait: SUCCESS (68.255s) [514.307522] [122/133] (509s left) gem_wait (busy) [514.395237] Starting subtest: busy [514.397574] Starting dynamic subtest: all-engines [515.643525] Dynamic subtest all-engines: SUCCESS (1.249s) [515.656059] Starting dynamic subtest: rcs0 [516.186736] Dynamic subtest rcs0: SUCCESS (0.542s) [516.198062] Starting dynamic subtest: bcs0 [516.726337] Dynamic subtest bcs0: SUCCESS (0.539s) [516.736873] Starting dynamic subtest: vcs0 [518.716636] Dynamic subtest vcs0: SUCCESS (1.987s) [518.726964] Starting dynamic subtest: vcs1 [520.699582] Dynamic subtest vcs1: SUCCESS (1.980s) [520.711722] Starting dynamic subtest: vecs0 [522.747750] Dynamic subtest vecs0: SUCCESS (2.045s) [522.759995] Starting dynamic subtest: ccs0 [523.289821] Dynamic subtest ccs0: SUCCESS (0.541s) [523.292439] Subtest busy: SUCCESS (8.898s) [523.487978] [123/133] (500s left) gem_exec_schedule (u-lateslice) [523.566371] Starting subtest: u-lateslice [523.568641] Starting dynamic subtest: rcs0 [523.589252] Dynamic subtest rcs0: SUCCESS (0.029s) [523.599827] Starting dynamic subtest: bcs0 [523.610778] Dynamic subtest bcs0: SUCCESS (0.021s) [523.619784] Starting dynamic subtest: vcs0 [523.631206] Dynamic subtest vcs0: SUCCESS (0.020s) [523.640330] Starting dynamic subtest: vcs1 [523.654101] Dynamic subtest vcs1: SUCCESS (0.023s) [523.663763] Starting dynamic subtest: vecs0 [523.679746] Dynamic subtest vecs0: SUCCESS (0.025s) [523.693987] Starting dynamic subtest: ccs0 [523.705241] Dynamic subtest ccs0: SUCCESS (0.024s) [523.707626] Subtest u-lateslice: SUCCESS (0.146s) [524.817136] [124/133] (498s left) kms_psr (fbc-pr-sprite-render) [524.930044] Starting subtest: fbc-pr-sprite-render [524.934252] Subtest fbc-pr-sprite-render: SKIP (0.000s) [525.001257] [125/133] (498s left) gem_userptr_blits (sync-unmap-after-close) [525.067769] Starting subtest: sync-unmap-after-close [525.079139] Subtest sync-unmap-after-close: SUCCESS (0.011s) [525.196693] [126/133] (498s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [525.284492] Starting subtest: plane-upscale-20x20-with-rotation [525.286738] Starting dynamic subtest: pipe-A [525.508982] Dynamic subtest pipe-A: SUCCESS (0.227s) [525.518451] Starting dynamic subtest: pipe-B [526.804845] Dynamic subtest pipe-B: SUCCESS (1.294s) [526.814764] Starting dynamic subtest: pipe-C [528.137393] Dynamic subtest pipe-C: SUCCESS (1.331s) [528.147628] Starting dynamic subtest: pipe-D [529.470936] Dynamic subtest pipe-D: SUCCESS (1.331s) [529.473432] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.189s) [530.666131] [127/133] (493s left) gem_exec_balancer (full-late-pulse) [530.726231] Starting subtest: full-late-pulse [535.561218] Subtest full-late-pulse: SUCCESS (4.834s) [535.889592] [128/133] (487s left) api_intel_bb (intel-bb-blit-x) [535.951505] Starting subtest: intel-bb-blit-x [539.729939] Subtest intel-bb-blit-x: SUCCESS (3.778s) [539.838913] [129/133] (484s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [539.886257] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [539.992481] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [540.070959] [130/133] (483s left) gem_spin_batch (resubmit-new) [540.121981] Starting subtest: resubmit-new [540.124793] Starting dynamic subtest: rcs0 [540.135896] Dynamic subtest rcs0: SUCCESS (0.013s) [540.160120] Starting dynamic subtest: bcs0 [540.162531] Dynamic subtest bcs0: SUCCESS (0.007s) [540.174927] Starting dynamic subtest: vcs0 [540.177241] Dynamic subtest vcs0: SUCCESS (0.007s) [540.186438] Starting dynamic subtest: vcs1 [540.188641] Dynamic subtest vcs1: SUCCESS (0.006s) [540.197787] Starting dynamic subtest: vecs0 [540.199931] Dynamic subtest vecs0: SUCCESS (0.006s) [540.208651] Starting dynamic subtest: ccs0 [540.210847] Dynamic subtest ccs0: SUCCESS (0.008s) [540.213081] Subtest resubmit-new: SUCCESS (0.052s) [541.745675] [131/133] (482s left) drm_read (short-buffer-block) [541.896109] Starting subtest: short-buffer-block [541.898617] Subtest short-buffer-block: SUCCESS (0.000s) [542.058541] [132/133] (481s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [542.157554] Starting subtest: psr-indfb-scaledprimary [547.899217] Subtest psr-indfb-scaledprimary: SUCCESS (5.744s) [548.013232] [133/133] (476s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [548.123220] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [552.660367] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.540s) [553.797562] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: gem_basic results: parsing output: 2/ for test: gem_mmap results: parsing output: 3/ for test: perf_pmu results: parsing output: 4/ for test: kms_selftest results: parsing output: 5/ for test: kms_busy results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: vgem_basic results: parsing output: 8/ for test: kms_cursor_legacy results: parsing output: 9/ for test: gem_render_copy results: parsing output: 10/ for test: gem_exec_endless results: parsing output: 11/ for test: kms_pm_rpm results: parsing output: 12/ for test: i915_pm_rpm results: parsing output: 13/ for test: kms_invalid_mode results: parsing output: 14/ for test: kms_color_pipeline results: parsing output: 15/ for test: gem_lmem_swapping results: parsing output: 16/ for test: i915_query results: parsing output: 17/ for test: prime_vgem results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: kms_cursor_legacy results: parsing output: 22/ for test: gen9_exec_parse results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: gem_create results: parsing output: 25/ for test: kms_psr results: parsing output: 26/ for test: gem_exec_reloc results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: i915_module_load results: parsing output: 29/ for test: perf_pmu results: parsing output: 30/ for test: kms_psr2_sf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_render_copy results: parsing output: 33/ for test: kms_flip_scaled_crc results: parsing output: 34/ for test: kms_ccs results: parsing output: 35/ for test: kms_cursor_crc results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_pwrite results: parsing output: 38/ for test: gem_mmap_gtt results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_plane_scaling results: parsing output: 41/ for test: gem_exec_schedule results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_flip results: parsing output: 49/ for test: gem_ctx_param results: parsing output: 50/ for test: kms_psr2_sf results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: perf_pmu results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_exec_params results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_exec_fence results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: perf results: parsing output: 61/ for test: kms_chamelium_edid results: parsing output: 62/ for test: kms_dsc results: parsing output: 63/ for test: kms_cursor_edge_walk results: parsing output: 64/ for test: kms_content_protection results: parsing output: 65/ for test: kms_psr results: parsing output: 66/ for test: kms_plane results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_flip results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: kms_flip results: parsing output: 71/ for test: kms_atomic results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: kms_chamelium_hpd results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: syncobj_wait results: parsing output: 80/ for test: gem_mmap_gtt results: parsing output: 81/ for test: gem_exec_fence results: parsing output: 82/ for test: kms_flip_scaled_crc results: parsing output: 83/ for test: syncobj_wait results: parsing output: 84/ for test: kms_vblank results: parsing output: 85/ for test: core_getversion results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: template results: parsing output: 90/ for test: gem_partial_pwrite_pread results: parsing output: 91/ for test: i915_drm_fdinfo results: parsing output: 92/ for test: gem_exec_fence results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_pm_backlight results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_plane results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_plane_alpha_blend results: parsing output: 101/ for test: kms_atomic_transition results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_exec_store results: parsing output: 104/ for test: gem_ctx_persistence results: parsing output: 105/ for test: api_intel_allocator results: parsing output: 106/ for test: syncobj_wait results: parsing output: 107/ for test: i915_pm_rps results: parsing output: 108/ for test: kms_psr2_sf results: parsing output: 109/ for test: kms_lease results: parsing output: 110/ for test: kms_addfb_basic results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: gem_ctx_persistence results: parsing output: 114/ for test: syncobj_basic results: parsing output: 115/ for test: gem_ctx_shared results: parsing output: 116/ for test: gem_mmap_offset results: parsing output: 117/ for test: sysfs_timeslice_duration results: parsing output: 118/ for test: gem_readwrite results: parsing output: 119/ for test: kms_pipe_b_c_ivb results: parsing output: 120/ for test: prime_busy results: parsing output: 121/ for test: gem_wait results: parsing output: 122/ for test: gem_exec_schedule results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: gem_userptr_blits results: parsing output: 125/ for test: kms_plane_scaling results: parsing output: 126/ for test: gem_exec_balancer results: parsing output: 127/ for test: api_intel_bb results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: gem_spin_batch results: parsing output: 130/ for test: drm_read results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.