[57.229430] Initializing watchdogs [57.229475] /dev/watchdog0 [57.243249] [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.247745] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.250068] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.253413] [001/132] (960s left) gem_flink_race (flink_close) [57.308750] Starting subtest: flink_close [62.397574] Subtest flink_close: SUCCESS (5.087s) [62.496308] [002/132] (955s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [62.610817] Starting subtest: plane-upscale-20x20-with-pixel-format [62.613132] Starting dynamic subtest: pipe-A [63.668997] Dynamic subtest pipe-A: SUCCESS (1.061s) [63.675900] Starting dynamic subtest: pipe-B [65.812803] Dynamic subtest pipe-B: SUCCESS (2.143s) [65.821347] Starting dynamic subtest: pipe-C [67.016991] Dynamic subtest pipe-C: SUCCESS (1.203s) [67.026243] Starting dynamic subtest: pipe-D [68.256046] Dynamic subtest pipe-D: SUCCESS (1.237s) [68.258909] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.648s) [69.461739] [003/132] (948s left) gem_exec_schedule (semaphore-noskip) [69.551241] Starting subtest: semaphore-noskip [69.962244] Subtest semaphore-noskip: SUCCESS (0.412s) [70.329153] [004/132] (947s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [70.434052] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [70.438350] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [70.555147] [005/132] (947s left) api_intel_bb (delta-check) [70.603909] Starting subtest: delta-check [70.608338] Subtest delta-check: SUCCESS (0.006s) [70.768660] [006/132] (947s left) gem_exec_flush (basic-batch-kernel-default-uc) [70.826590] Starting subtest: basic-batch-kernel-default-uc [77.090255] Subtest basic-batch-kernel-default-uc: SUCCESS (6.265s) [77.299773] [007/132] (940s left) gem_mmap_gtt (cpuset-big-copy-xy) [77.367323] Subtest cpuset-big-copy-XY: SKIP (0.000s) [77.434214] [008/132] (940s left) gem_eio (in-flight-10ms) [77.652917] Starting subtest: in-flight-10ms [85.738013] Subtest in-flight-10ms: SUCCESS (8.081s) [85.931725] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true [85.934747] [009/132] (932s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [85.999552] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [86.061197] [010/132] (932s left) drm_read (short-buffer-block) [86.236933] Starting subtest: short-buffer-block [86.239236] Subtest short-buffer-block: SUCCESS (0.000s) [86.378584] [011/132] (931s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [86.486092] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [93.522117] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.040s) [93.669885] [012/132] (924s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [93.781586] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [93.785612] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [93.907562] [013/132] (924s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [94.022214] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [94.404751] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [97.163275] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.757s) [97.175906] Starting dynamic subtest: pipe-A-eDP-1-4 [99.336822] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s) [99.347527] Starting dynamic subtest: pipe-A-eDP-1-4 [101.346892] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [101.358239] Starting dynamic subtest: pipe-A-eDP-1-x [103.540090] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s) [103.909621] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [106.694469] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.789s) [106.708386] Starting dynamic subtest: pipe-B-eDP-1-4 [108.880853] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s) [108.891891] Starting dynamic subtest: pipe-B-eDP-1-4 [110.891243] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s) [110.902321] Starting dynamic subtest: pipe-B-eDP-1-x [113.081046] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [113.443913] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [116.222573] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.784s) [116.232405] Starting dynamic subtest: pipe-C-eDP-1-4 [118.397284] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [118.429526] Starting dynamic subtest: pipe-C-eDP-1-4 [120.408065] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s) [120.420463] Starting dynamic subtest: pipe-C-eDP-1-x [122.597821] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s) [122.964772] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [125.751031] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.791s) [125.762752] Starting dynamic subtest: pipe-D-eDP-1-4 [127.936781] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.186s) [127.948074] Starting dynamic subtest: pipe-D-eDP-1-4 [129.947069] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s) [129.956088] Starting dynamic subtest: pipe-D-eDP-1-x [132.137102] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [132.140063] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.114s) [133.353426] [014/132] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [133.463318] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [133.467661] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [133.588561] [015/132] (884s left) kms_psr (fbc-pr-primary-render) [133.694985] Starting subtest: fbc-pr-primary-render [133.700065] Subtest fbc-pr-primary-render: SKIP (0.000s) [133.789726] [016/132] (884s left) gem_ppgtt (flink-and-close-vma-leak) [133.852313] Starting subtest: flink-and-close-vma-leak [133.893534] Subtest flink-and-close-vma-leak: SUCCESS (0.042s) [134.057325] [017/132] (884s left) gem_exec_alignment (pi) [134.117652] Starting subtest: pi [185.589221] Subtest pi: SUCCESS (51.468s) [186.673716] [018/132] (831s left) gen9_exec_parse (bb-oversize) [186.778364] Subtest bb-oversize: SKIP (0.000s) [186.873294] [019/132] (831s left) kms_dp_linktrain_fallback (dsc-fallback) [186.979292] Starting subtest: dsc-fallback [186.986093] Subtest dsc-fallback: SKIP (0.000s) [187.079031] [020/132] (831s left) kms_vblank (query-idle) [187.181511] Starting subtest: query-idle [187.183476] Starting dynamic subtest: pipe-A-eDP-1 [188.922155] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s) [188.937068] Starting dynamic subtest: pipe-D-eDP-1 [191.358407] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.431s) [191.360617] Subtest query-idle: SUCCESS (4.178s) [192.214578] [021/132] (826s left) gem_mmap_wc (coherency) [192.280402] Subtest coherency: SKIP (0.000s) [192.343244] [022/132] (826s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [197.406397] Starting subtest: pr-overlay-primary-update-sf-dmg-area [197.411039] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s) [198.274311] [023/132] (820s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [198.363525] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [198.367693] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [198.495465] [024/132] (820s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [198.598207] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [198.609979] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s) [198.758417] [025/132] (819s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [198.858723] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [205.737604] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.881s) [205.901820] [026/132] (812s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [206.012284] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [206.016563] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [206.139635] [027/132] (812s left) kms_pm_rpm (universal-planes-dpms) [208.106076] Starting subtest: universal-planes-dpms [208.108783] Starting dynamic subtest: plane-33 [216.800219] Dynamic subtest plane-33: SUCCESS (8.698s) [216.811339] Starting dynamic subtest: plane-63 [225.095418] Dynamic subtest plane-63: SUCCESS (8.292s) [225.108047] Starting dynamic subtest: plane-93 [233.684583] Dynamic subtest plane-93: SUCCESS (8.588s) [233.696078] Starting dynamic subtest: plane-123 [242.290414] Dynamic subtest plane-123: SUCCESS (8.603s) [242.307721] Starting dynamic subtest: plane-133 [250.588233] Dynamic subtest plane-133: SUCCESS (8.296s) [250.599609] Starting dynamic subtest: plane-143 [259.225850] Dynamic subtest plane-143: SUCCESS (8.635s) [259.228854] Subtest universal-planes-dpms: SUCCESS (51.125s) [259.609051] [028/132] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [259.715594] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [259.720068] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [259.828652] [029/132] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [259.935281] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [259.939544] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [260.062012] [030/132] (758s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [260.121555] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [260.207359] [031/132] (758s left) gem_softpin (allocator-evict) [260.269359] Starting subtest: allocator-evict [260.271743] Starting dynamic subtest: rcs0 [283.710773] Dynamic subtest rcs0: SUCCESS (23.441s) [283.719944] Starting dynamic subtest: bcs0 [307.791818] Dynamic subtest bcs0: SUCCESS (24.079s) [307.803205] Starting dynamic subtest: vcs0 [331.648641] Dynamic subtest vcs0: SUCCESS (23.854s) [331.660044] Starting dynamic subtest: vcs1 [355.424824] Dynamic subtest vcs1: SUCCESS (23.774s) [355.434029] Starting dynamic subtest: vecs0 [379.226935] Dynamic subtest vecs0: SUCCESS (23.800s) [379.236886] Starting dynamic subtest: ccs0 [402.887488] Dynamic subtest ccs0: SUCCESS (23.658s) [402.890448] Subtest allocator-evict: SUCCESS (142.616s) [402.990088] [032/132] (616s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [403.137995] Starting subtest: fbc-rgb565-draw-mmap-wc [407.241754] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.107s) [408.399917] [033/132] (610s left) gem_exec_schedule (implicit-read-write) [408.486756] Starting subtest: implicit-read-write [408.488693] Starting dynamic subtest: rcs0 [408.585140] Dynamic subtest rcs0: SUCCESS (0.107s) [408.593863] Starting dynamic subtest: vcs0 [408.664561] Dynamic subtest vcs0: SUCCESS (0.078s) [408.675973] Starting dynamic subtest: vcs1 [408.738864] Dynamic subtest vcs1: SUCCESS (0.074s) [408.750214] Starting dynamic subtest: vecs0 [408.821644] Dynamic subtest vecs0: SUCCESS (0.082s) [408.833534] Starting dynamic subtest: ccs0 [408.910994] Dynamic subtest ccs0: SUCCESS (0.089s) [408.913619] Subtest implicit-read-write: SUCCESS (0.433s) [410.014841] [034/132] (609s left) kms_flip (flip-vs-panning-vs-hang) [410.121206] Starting subtest: flip-vs-panning-vs-hang [410.123599] Starting dynamic subtest: A-eDP1 [460.417851] Dynamic subtest A-eDP1: SUCCESS (50.296s) [460.429241] Starting dynamic subtest: D-eDP1 [510.400237] Dynamic subtest D-eDP1: SUCCESS (49.981s) [510.402410] Subtest flip-vs-panning-vs-hang: SUCCESS (100.281s) [511.565914] [035/132] (507s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [511.625515] Starting subtest: invalid-multi-wait-unsubmitted [511.627733] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [511.741358] [036/132] (507s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [511.859765] Starting subtest: y-tiled-addfb-size-offset-overflow [511.864148] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [512.005874] [037/132] (507s left) kms_addfb_basic (unused-handle) [512.071829] Starting subtest: unused-handle [512.074370] Subtest unused-handle: SUCCESS (0.000s) [512.249777] [038/132] (507s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [512.317709] Starting subtest: multi-wait-for-submit-submitted-signaled [512.319600] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [512.454948] [039/132] (506s left) kms_selftest (drm_damage_helper) [512.494896] Starting subtest: drm_damage_helper [512.534292] Starting dynamic subtest: drm_test_damage_iter_no_damage [512.688044] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.150s) [512.698153] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [512.808712] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.120s) [512.818602] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [512.929730] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.120s) [512.939953] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [513.014861] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.085s) [513.024664] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [513.144060] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.127s) [513.152551] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [513.303554] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.158s) [513.312426] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [513.424926] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.119s) [513.434116] Starting dynamic subtest: drm_test_damage_iter_simple_damage [513.569125] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.143s) [513.583032] Starting dynamic subtest: drm_test_damage_iter_single_damage [513.706362] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.137s) [513.714530] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [513.849421] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.142s) [513.857891] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [514.009674] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.160s) [514.018135] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [514.157594] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.147s) [514.166580] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [514.285928] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.125s) [514.295804] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [514.405325] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.119s) [514.413699] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [514.506035] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.100s) [514.516894] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [514.598899] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.092s) [514.609451] Starting dynamic subtest: drm_test_damage_iter_damage [514.683816] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.085s) [514.694084] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [514.790844] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.106s) [514.800060] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [514.911949] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.119s) [514.922050] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [515.065147] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.152s) [515.075520] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [515.182583] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.118s) [515.184685] Subtest drm_damage_helper: SUCCESS (2.685s) [515.374766] [040/132] (503s left) kms_async_flips (test-time-stamp-atomic) [515.464664] Starting subtest: test-time-stamp-atomic [515.835726] Starting dynamic subtest: pipe-A-eDP-1 [516.638195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.800s) [517.005778] Starting dynamic subtest: pipe-B-eDP-1 [517.765849] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s) [518.143090] Starting dynamic subtest: pipe-C-eDP-1 [518.903135] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s) [519.282533] Starting dynamic subtest: pipe-D-eDP-1 [520.042259] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s) [520.044650] Subtest test-time-stamp-atomic: SUCCESS (4.578s) [521.222729] [041/132] (498s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [521.332155] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [521.334294] Starting dynamic subtest: pipe-A-eDP-1 [521.354413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [521.364727] Starting dynamic subtest: pipe-B-eDP-1 [521.385412] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [521.394024] Starting dynamic subtest: pipe-C-eDP-1 [521.413247] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [521.421481] Starting dynamic subtest: pipe-D-eDP-1 [521.440510] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [521.442407] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.011s) [523.674644] [042/132] (495s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [523.823173] Starting subtest: dp-mst-lic-type-0-hdcp14 [523.827566] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [523.971856] [043/132] (495s left) kms_joiner (basic-force-big-joiner) [524.080724] Starting subtest: basic-force-big-joiner [524.082964] Starting dynamic subtest: single [527.393898] Dynamic subtest single: SUCCESS (3.323s) [527.396189] Subtest basic-force-big-joiner: SUCCESS (3.324s) [528.597484] [044/132] (490s left) gem_workarounds (reset-fd) [528.667425] Starting subtest: reset-fd [528.830424] Subtest reset-fd: SUCCESS (0.162s) [528.993990] [045/132] (490s left) gem_partial_pwrite_pread (reads-snoop) [529.052684] Subtest reads-snoop: SKIP (0.000s) [529.118132] [046/132] (490s left) gem_render_copy (y-tiled-ccs-to-linear) [529.176177] Starting subtest: y-tiled-ccs-to-linear [529.180458] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [529.381231] [047/132] (490s left) i915_query (query-regions-sanity-check) [529.439963] Starting subtest: query-regions-sanity-check [529.446241] Subtest query-regions-sanity-check: SUCCESS (0.010s) [529.607315] [048/132] (490s left) kms_cursor_crc (cursor-rapid-movement-128x42) [529.842074] Starting subtest: cursor-rapid-movement-128x42 [529.889953] Subtest cursor-rapid-movement-128x42: SKIP (0.043s) [530.145780] [049/132] (489s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [530.207345] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [530.209516] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [530.352148] [050/132] (489s left) gem_madvise (dontneed-after-mmap) [530.388888] Starting subtest: dontneed-after-mmap [530.415323] Subtest dontneed-after-mmap: SUCCESS (0.029s) [530.569061] [051/132] (489s left) prime_vgem (shrink) [530.641222] Starting subtest: shrink [530.653623] Subtest shrink: SUCCESS (0.013s) [530.792448] [052/132] (489s left) kms_flip (plain-flip-interruptible) [530.891145] Starting subtest: plain-flip-interruptible [530.895289] Starting dynamic subtest: A-eDP1 [532.571668] Dynamic subtest A-eDP1: SUCCESS (1.678s) [532.582693] Starting dynamic subtest: B-eDP1 [534.203971] Dynamic subtest B-eDP1: SUCCESS (1.631s) [534.215090] Starting dynamic subtest: C-eDP1 [535.842331] Dynamic subtest C-eDP1: SUCCESS (1.637s) [535.854998] Starting dynamic subtest: D-eDP1 [537.460608] Dynamic subtest D-eDP1: SUCCESS (1.615s) [537.462949] Subtest plain-flip-interruptible: SUCCESS (6.571s) [538.645903] [053/132] (481s left) gem_userptr_blits (sync-unmap-after-close) [538.720446] Starting subtest: sync-unmap-after-close [538.733533] Subtest sync-unmap-after-close: SUCCESS (0.011s) [538.886465] [054/132] (481s left) kms_psr (fbc-psr2-primary-mmap-gtt) [538.983998] Starting subtest: fbc-psr2-primary-mmap-gtt [538.986261] Starting dynamic subtest: eDP-1 [538.990503] Dynamic subtest eDP-1: SKIP (0.000s) [538.994730] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [539.081591] [055/132] (480s left) gem_partial_pwrite_pread (writes-after-reads) [539.142620] Subtest writes-after-reads: SKIP (0.000s) [539.224405] [056/132] (480s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [539.325788] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [539.328067] Starting dynamic subtest: pipe-A-eDP-1 [540.161720] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s) [540.170936] Starting dynamic subtest: pipe-B-eDP-1 [541.888653] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.725s) [541.898208] Starting dynamic subtest: pipe-C-eDP-1 [543.462074] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.571s) [543.471147] Starting dynamic subtest: pipe-D-eDP-1 [545.028057] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.563s) [545.030345] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.695s) [546.286966] [057/132] (473s left) gem_caching (writes) [546.354627] Subtest writes: SKIP (0.000s) [546.429016] [058/132] (473s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [546.530347] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [550.164830] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.639s) [551.370716] [059/132] (468s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [551.473067] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [551.477277] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [551.617800] [060/132] (468s left) gem_exec_async (forked-writes) [551.693377] Starting subtest: forked-writes [551.695757] Starting dynamic subtest: rcs0 [551.720582] Dynamic subtest rcs0: SUCCESS (0.027s) [551.731472] Starting dynamic subtest: bcs0 [551.745056] Dynamic subtest bcs0: SUCCESS (0.023s) [551.757117] Starting dynamic subtest: vcs0 [551.768745] Dynamic subtest vcs0: SUCCESS (0.023s) [551.782432] Starting dynamic subtest: vcs1 [551.794677] Dynamic subtest vcs1: SUCCESS (0.024s) [551.804845] Starting dynamic subtest: vecs0 [551.817558] Dynamic subtest vecs0: SUCCESS (0.022s) [551.828873] Starting dynamic subtest: ccs0 [551.841791] Dynamic subtest ccs0: SUCCESS (0.023s) [551.844097] Subtest forked-writes: SUCCESS (0.149s) [552.123437] [061/132] (468s left) i915_drm_fdinfo (virtual-busy) [552.166012] Starting subtest: virtual-busy [552.169776] Subtest virtual-busy: SKIP (0.000s) [552.266727] [062/132] (467s left) gem_ccs (ctrl-surf-copy) [552.329555] Starting subtest: ctrl-surf-copy [552.333898] Subtest ctrl-surf-copy: SKIP (0.000s) [552.473089] [063/132] (467s left) syncobj_timeline (wait-delayed-signal) [552.538283] Starting subtest: wait-delayed-signal [552.642035] Subtest wait-delayed-signal: SUCCESS (0.102s) [552.741280] [064/132] (467s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [552.852489] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [553.531895] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s) [553.762620] [065/132] (466s left) kms_color (legacy-gamma) [553.862972] Starting subtest: legacy-gamma [553.864877] Starting dynamic subtest: pipe-A-eDP-1 [554.578270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [554.593108] Starting dynamic subtest: pipe-B-eDP-1 [555.946364] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.373s) [555.956221] Starting dynamic subtest: pipe-C-eDP-1 [557.329436] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s) [557.339088] Starting dynamic subtest: pipe-D-eDP-1 [558.657207] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s) [558.659638] Subtest legacy-gamma: SUCCESS (4.793s) [559.487278] [066/132] (460s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [559.593808] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [559.606054] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s) [559.758037] [067/132] (460s left) kms_getfb (getfb-handle-zero) [559.857973] Starting subtest: getfb-handle-zero [559.860264] Subtest getfb-handle-zero: SUCCESS (0.000s) [559.980778] [068/132] (460s left) gem_vm_create (invalid-destroy) [560.045403] Starting subtest: invalid-destroy [560.050195] Subtest invalid-destroy: SUCCESS (0.002s) [560.188260] [069/132] (460s left) gem_mmap_offset (bad-flags) [560.248667] Starting subtest: bad-flags [560.250951] Subtest bad-flags: SUCCESS (0.000s) [560.356980] [070/132] (460s left) syncobj_timeline (reset-signaled) [560.415852] Starting subtest: reset-signaled [560.417522] Subtest reset-signaled: SUCCESS (0.000s) [560.530580] [071/132] (460s left) kms_lease (page-flip-implicit-plane) [560.620537] Starting subtest: page-flip-implicit-plane [560.622420] Starting dynamic subtest: pipe-A-eDP-1 [561.105873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s) [561.115070] Starting dynamic subtest: pipe-B-eDP-1 [562.204592] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.095s) [562.215097] Starting dynamic subtest: pipe-C-eDP-1 [563.334454] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s) [563.344035] Starting dynamic subtest: pipe-D-eDP-1 [564.455082] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s) [564.457382] Subtest page-flip-implicit-plane: SUCCESS (3.835s) [565.311908] [072/132] (455s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [565.421301] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [565.423581] Starting dynamic subtest: pipe-A-default-mode [565.722366] Dynamic subtest pipe-A-default-mode: SKIP (0.300s) [565.727107] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.302s) [566.540153] [073/132] (454s left) sysfs_preempt_timeout (timeout) [566.603706] Starting subtest: timeout [566.606302] Starting dynamic subtest: vecs0 [575.910755] Dynamic subtest vecs0: SUCCESS (9.302s) [575.921957] Starting dynamic subtest: ccs0 [577.271865] Dynamic subtest ccs0: SUCCESS (1.360s) [577.282980] Starting dynamic subtest: vcs0 [586.919658] Dynamic subtest vcs0: SUCCESS (9.644s) [586.931801] Starting dynamic subtest: bcs0 [588.350679] Dynamic subtest bcs0: SUCCESS (1.429s) [588.361981] Starting dynamic subtest: rcs0 [589.643814] Dynamic subtest rcs0: SUCCESS (1.290s) [589.655243] Starting dynamic subtest: vcs1 [598.954896] Dynamic subtest vcs1: SUCCESS (9.306s) [598.957465] Subtest timeout: SUCCESS (32.346s) [599.052604] [074/132] (421s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [599.166613] Starting subtest: fbcpsr-rgb101010-draw-blt [605.897025] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.732s) [606.036676] [075/132] (414s left) kms_psr (psr2-sprite-plane-move) [606.120809] Starting subtest: psr2-sprite-plane-move [606.122989] Starting dynamic subtest: eDP-1 [607.843083] Dynamic subtest eDP-1: SUCCESS (1.721s) [607.845389] Subtest psr2-sprite-plane-move: SUCCESS (1.722s) [608.698949] [076/132] (412s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [608.807097] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [609.817467] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s) [609.975707] [077/132] (410s left) gem_lmem_swapping (massive-random) [610.021422] Subtest massive-random: SKIP (0.000s) [610.062466] [078/132] (410s left) kms_cursor_legacy (cursor-vs-flip-toggle) [610.187425] Starting subtest: cursor-vs-flip-toggle [641.039180] Subtest cursor-vs-flip-toggle: SUCCESS (30.847s) [641.927893] [079/132] (378s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [642.028282] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [642.032234] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [642.147079] [080/132] (378s left) kms_chamelium_frames (dp-crc-fast) [642.534741] Subtest dp-crc-fast: SKIP (0.000s) [643.316873] [081/132] (377s left) gem_pxp (hw-rejects-pxp-buffer) [643.444724] Starting subtest: hw-rejects-pxp-buffer [643.449358] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [643.575492] [082/132] (377s left) kms_plane_alpha_blend (alpha-opaque-fb) [643.681280] Starting subtest: alpha-opaque-fb [643.966726] Starting dynamic subtest: pipe-A-eDP-1 [644.659330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.690s) [644.668670] Starting dynamic subtest: pipe-D-eDP-1 [645.979750] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s) [645.981921] Subtest alpha-opaque-fb: SUCCESS (2.298s) [646.817354] [083/132] (374s left) gem_exec_flush (basic-uc-ro-default) [646.881384] Starting subtest: basic-uc-ro-default [652.340349] Subtest basic-uc-ro-default: SUCCESS (5.460s) [652.553430] [084/132] (368s left) api_intel_allocator (fork-simple-stress-signal) [652.618715] Starting subtest: fork-simple-stress-signal [658.023158] Subtest fork-simple-stress-signal: SUCCESS (5.403s) [658.176977] [085/132] (362s left) gem_ringfill (engines-basic) [663.896322] Starting subtest: engines-basic [663.898958] Starting dynamic subtest: rcs0 [663.960046] Dynamic subtest rcs0: SUCCESS (0.063s) [663.972233] Starting dynamic subtest: bcs0 [664.005124] Dynamic subtest bcs0: SUCCESS (0.043s) [664.015700] Starting dynamic subtest: vcs0 [664.048251] Dynamic subtest vcs0: SUCCESS (0.041s) [664.059715] Starting dynamic subtest: vcs1 [664.092082] Dynamic subtest vcs1: SUCCESS (0.042s) [664.102340] Starting dynamic subtest: vecs0 [664.134874] Dynamic subtest vecs0: SUCCESS (0.041s) [664.144797] Starting dynamic subtest: ccs0 [664.178807] Dynamic subtest ccs0: SUCCESS (0.042s) [664.181226] Subtest engines-basic: SUCCESS (0.285s) [664.282266] [086/132] (356s left) kms_atomic_transition (plane-toggle-modeset-transition) [664.381022] Starting subtest: plane-toggle-modeset-transition [664.383116] Starting dynamic subtest: pipe-A-eDP-1 [677.116436] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.735s) [677.130567] Starting dynamic subtest: pipe-B-eDP-1 [689.540984] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.419s) [689.543624] Subtest plane-toggle-modeset-transition: SUCCESS (25.161s) [690.376825] [087/132] (330s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [690.490057] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [690.494314] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [690.612925] [088/132] (330s left) syncobj_wait (wait-all-delayed-signal) [690.682630] Starting subtest: wait-all-delayed-signal [690.784623] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [690.887264] [089/132] (330s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [691.010833] Starting subtest: cursor-tearing-framebuffer-change [691.013105] Starting dynamic subtest: pipe-A-eDP-1 [691.579778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [691.589382] Starting dynamic subtest: pipe-D-eDP-1 [692.809342] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s) [692.811658] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.800s) [693.696694] [090/132] (327s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [693.921340] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [693.925572] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [694.129900] [091/132] (327s left) gem_create (create-ext-placement-each) [694.365660] Starting subtest: create-ext-placement-each [694.368229] Subtest create-ext-placement-each: SUCCESS (0.000s) [694.559365] [092/132] (326s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [694.662105] Starting subtest: plane-use-after-nonblocking-unbind [694.664366] Starting dynamic subtest: pipe-A-eDP-1 [694.721884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s) [695.020732] Starting dynamic subtest: pipe-B-eDP-1 [695.826479] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.814s) [696.134138] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.472s) [697.011931] [093/132] (324s left) prime_vgem (basic-read) [697.087359] Starting subtest: basic-read [697.094663] Subtest basic-read: SKIP (0.006s) [697.219196] [094/132] (324s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [697.322083] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [697.324505] Starting dynamic subtest: pipe-A-default-mode [697.615743] Dynamic subtest pipe-A-default-mode: SKIP (0.292s) [697.620416] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.294s) [698.449465] [095/132] (323s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [698.546077] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [698.548185] Starting dynamic subtest: pipe-A-eDP-1 [698.568318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s) [698.577999] Starting dynamic subtest: pipe-B-eDP-1 [698.597734] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [698.606842] Starting dynamic subtest: pipe-C-eDP-1 [698.626497] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s) [698.635798] Starting dynamic subtest: pipe-D-eDP-1 [698.656119] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [698.658358] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s) [700.810359] [096/132] (320s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [700.926050] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [707.485407] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.562s) [707.636521] [097/132] (314s left) gem_exec_capture (capture) [707.693202] Starting subtest: capture [707.695100] Starting dynamic subtest: rcs0-smem [708.529618] Dynamic subtest rcs0-smem: SUCCESS (0.835s) [708.540892] Starting dynamic subtest: bcs0-smem [709.853997] Dynamic subtest bcs0-smem: SUCCESS (1.324s) [709.864044] Starting dynamic subtest: vcs0-smem [710.682197] Dynamic subtest vcs0-smem: SUCCESS (0.827s) [710.693136] Starting dynamic subtest: vcs1-smem [711.503400] Dynamic subtest vcs1-smem: SUCCESS (0.823s) [711.515033] Starting dynamic subtest: vecs0-smem [712.906575] Dynamic subtest vecs0-smem: FAIL (1.341s) [712.917644] Starting dynamic subtest: ccs0-smem [714.166902] Dynamic subtest ccs0-smem: SUCCESS (1.318s) [714.169817] Subtest capture: FAIL (6.473s) [714.307119] [098/132] (307s left) kms_plane_scaling (intel-max-src-size) [714.416968] Starting subtest: intel-max-src-size [714.423640] Subtest intel-max-src-size: SKIP (0.000s) [714.531396] [099/132] (307s left) gem_exec_whisper (basic-contexts) [714.601739] Starting subtest: basic-contexts [721.407715] Subtest basic-contexts: SUCCESS (6.803s) [721.615917] [100/132] (300s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [721.726900] Starting subtest: bad-aux-stride-yf-tiled-ccs [721.729174] Starting dynamic subtest: pipe-A-eDP-1 [721.751509] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [721.763508] Starting dynamic subtest: pipe-B-eDP-1 [721.785573] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [721.796841] Starting dynamic subtest: pipe-C-eDP-1 [721.817952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [721.827434] Starting dynamic subtest: pipe-D-eDP-1 [721.849182] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [721.853549] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s) [723.975558] [101/132] (297s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [724.088452] Starting subtest: fbc-indfb-scaledprimary [727.079579] Subtest fbc-indfb-scaledprimary: SUCCESS (2.993s) [728.295244] [102/132] (293s left) gem_exec_fence (long-history) [728.720565] Starting subtest: long-history [735.695033] Subtest long-history: SUCCESS (6.975s) [736.214012] [103/132] (285s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [741.219901] Starting subtest: pr-cursor-plane-move-continuous-sf [741.224619] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s) [742.104174] [104/132] (279s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [742.202086] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [742.204375] Starting dynamic subtest: pipe-A-eDP-1 [742.227277] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [742.238234] Starting dynamic subtest: pipe-B-eDP-1 [742.260052] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [742.269321] Starting dynamic subtest: pipe-C-eDP-1 [742.291049] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [742.299953] Starting dynamic subtest: pipe-D-eDP-1 [742.321417] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [742.326048] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [744.465783] [105/132] (277s left) kms_big_fb (x-tiled-8bpp-rotate-0) [744.573859] Starting subtest: x-tiled-8bpp-rotate-0 [745.821218] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.246s) [745.946592] [106/132] (276s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [746.049489] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [753.433657] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.386s) [753.614044] [107/132] (268s left) syncobj_wait (multi-wait-signaled) [753.677804] Starting subtest: multi-wait-signaled [753.680182] Subtest multi-wait-signaled: SUCCESS (0.000s) [753.810179] [108/132] (268s left) kms_chamelium_color (gamma) [753.899252] Subtest gamma: SKIP (0.000s) [753.949642] [109/132] (268s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [754.007378] Starting subtest: multi-wait-for-submit-available-submitted-signaled [754.009816] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s) [754.116399] [110/132] (268s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [754.515128] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [755.292429] [111/132] (267s left) vgem_basic (debugfs) [755.330590] Starting subtest: debugfs [755.332783] Subtest debugfs: SUCCESS (0.000s) [755.411961] [112/132] (266s left) prime_busy (after) [755.469356] Starting subtest: after [755.471782] Starting dynamic subtest: rcs0 [755.529681] Dynamic subtest rcs0: SUCCESS (0.059s) [755.541788] Starting dynamic subtest: bcs0 [755.604774] Dynamic subtest bcs0: SUCCESS (0.075s) [755.615991] Starting dynamic subtest: vcs0 [755.645054] Dynamic subtest vcs0: SUCCESS (0.040s) [755.654675] Starting dynamic subtest: vcs1 [755.684786] Dynamic subtest vcs1: SUCCESS (0.039s) [755.694437] Starting dynamic subtest: vecs0 [755.725583] Dynamic subtest vecs0: SUCCESS (0.040s) [755.735449] Starting dynamic subtest: ccs0 [755.766491] Dynamic subtest ccs0: SUCCESS (0.040s) [755.874814] Subtest after: SUCCESS (0.406s) [755.975040] [113/132] (266s left) gem_ctx_persistence (heartbeat-close) [756.046047] Starting subtest: heartbeat-close [756.050972] Subtest heartbeat-close: SKIP (0.000s) [756.185555] [114/132] (266s left) kms_big_fb (4-tiled-addfb) [756.279117] Starting subtest: 4-tiled-addfb [756.281413] Subtest 4-tiled-addfb: SUCCESS (0.000s) [756.411200] [115/132] (266s left) kms_dsc (dsc-fractional-bpp-with-bpc) [756.505837] Starting subtest: dsc-fractional-bpp-with-bpc [756.535105] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s) [756.602608] [116/132] (265s left) gem_exec_schedule (deep) [756.788677] Starting subtest: deep [756.791225] Starting dynamic subtest: rcs0 [762.583848] Dynamic subtest rcs0: SKIP (5.791s) [762.596629] Starting dynamic subtest: vcs0 [773.636433] Dynamic subtest vcs0: SUCCESS (11.054s) [773.648088] Starting dynamic subtest: vcs1 [785.301256] Dynamic subtest vcs1: SUCCESS (11.663s) [785.313630] Starting dynamic subtest: vecs0 [797.029606] Dynamic subtest vecs0: SUCCESS (11.725s) [797.040769] Starting dynamic subtest: ccs0 [809.978991] Dynamic subtest ccs0: SUCCESS (12.949s) [809.981609] Subtest deep: SUCCESS (53.188s) [811.071601] [117/132] (211s left) core_getstats (basic) [811.135057] Starting subtest: basic [811.137366] Subtest basic: SUCCESS (0.000s) [811.279911] [118/132] (211s left) gem_eio (wait-wedge-immediate) [811.522653] Starting subtest: wait-wedge-immediate [812.973290] Subtest wait-wedge-immediate: SUCCESS (1.452s) [813.142119] [119/132] (209s left) kms_psr (pr-no-drrs) [813.243327] Starting subtest: pr-no-drrs [813.247543] Subtest pr-no-drrs: SKIP (0.000s) [813.339789] [120/132] (209s left) kms_vblank (wait-forked-busy) [813.438265] Starting subtest: wait-forked-busy [813.440149] Starting dynamic subtest: pipe-A-eDP-1 [815.325688] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s) [815.340845] Starting dynamic subtest: pipe-D-eDP-1 [817.875665] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s) [817.878079] Subtest wait-forked-busy: SUCCESS (4.439s) [818.705128] [121/132] (204s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [818.762309] Starting subtest: etime-multi-wait-available-unsubmitted [818.866449] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s) [818.971372] [122/132] (203s left) kms_cursor_crc (cursor-offscreen-32x10) [819.129816] Starting subtest: cursor-offscreen-32x10 [819.178506] Subtest cursor-offscreen-32x10: SKIP (0.043s) [819.470650] [123/132] (203s left) gem_ctx_param (set-priority-invalid-size) [819.527494] Starting subtest: set-priority-invalid-size [819.529850] Subtest set-priority-invalid-size: SUCCESS (0.000s) [819.627916] [124/132] (203s left) kms_pm_rpm (cursor) [821.155986] Starting subtest: cursor [821.160885] Subtest cursor: SKIP (0.000s) [821.947979] [125/132] (200s left) i915_pm_rpm (system-suspend-execbuf) [824.087812] Starting subtest: system-suspend-execbuf [882.621273] Subtest system-suspend-execbuf: SUCCESS (46.970s) [883.028510] [126/132] (139s left) kms_psr (pr-sprite-plane-move) [883.126268] Starting subtest: pr-sprite-plane-move [883.130753] Subtest pr-sprite-plane-move: SKIP (0.000s) [883.229934] [127/132] (139s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [883.335421] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [883.337883] Starting dynamic subtest: pipe-A [883.356442] Dynamic subtest pipe-A: SKIP (0.017s) [883.367723] Starting dynamic subtest: pipe-B [883.385469] Dynamic subtest pipe-B: SKIP (0.030s) [883.396477] Starting dynamic subtest: pipe-C [883.421673] Dynamic subtest pipe-C: SKIP (0.030s) [883.437092] Starting dynamic subtest: pipe-D [883.450291] Dynamic subtest pipe-D: SKIP (0.030s) [883.454698] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.111s) [883.576665] [128/132] (139s left) gem_ctx_isolation (dirty-create) [883.645810] Starting subtest: dirty-create [883.647700] Starting dynamic subtest: rcs0 [883.830534] Dynamic subtest rcs0: SUCCESS (0.187s) [883.843018] Starting dynamic subtest: bcs0 [884.051668] Dynamic subtest bcs0: SUCCESS (0.220s) [884.064427] Starting dynamic subtest: vcs0 [884.280066] Dynamic subtest vcs0: SUCCESS (0.228s) [884.292709] Starting dynamic subtest: vcs1 [885.666961] Dynamic subtest vcs1: SUCCESS (1.386s) [885.677907] Starting dynamic subtest: vecs0 [887.706642] Dynamic subtest vecs0: SUCCESS (2.039s) [887.717063] Starting dynamic subtest: ccs0 [889.695178] Dynamic subtest ccs0: SUCCESS (1.988s) [889.697597] Subtest dirty-create: SUCCESS (6.053s) [889.955416] [129/132] (133s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite) [890.065155] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite [897.268981] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.204s) [897.433977] [130/132] (125s left) perf_pmu (init-busy) [897.475932] Starting subtest: init-busy [897.478240] Starting dynamic subtest: rcs0 [897.480561] Dynamic subtest rcs0: SUCCESS (0.001s) [897.493616] Starting dynamic subtest: bcs0 [897.495823] Dynamic subtest bcs0: SUCCESS (0.000s) [897.507675] Starting dynamic subtest: vcs0 [897.509578] Dynamic subtest vcs0: SUCCESS (0.001s) [897.519400] Starting dynamic subtest: vcs1 [897.521312] Dynamic subtest vcs1: SUCCESS (0.001s) [897.531041] Starting dynamic subtest: vecs0 [897.532821] Dynamic subtest vecs0: SUCCESS (0.000s) [897.542753] Starting dynamic subtest: ccs0 [897.544971] Dynamic subtest ccs0: SUCCESS (0.000s) [897.547190] Subtest init-busy: SUCCESS (0.008s) [897.617779] [131/132] (125s left) i915_module_load (reload) [897.655265] Starting subtest: reload [902.846064] Subtest reload: SUCCESS (5.194s) [902.890256] [132/132] (120s left) gem_pread (bench) [904.405934] Subtest bench: SKIP (0.000s) [904.495861] Closing watchdogs results: parsing output: 0/ for test: gem_flink_race results: parsing output: 1/ for test: kms_plane_scaling results: parsing output: 2/ for test: gem_exec_schedule results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: api_intel_bb results: parsing output: 5/ for test: gem_exec_flush results: parsing output: 6/ for test: gem_mmap_gtt results: parsing output: 7/ for test: gem_eio results: parsing output: 8/ for test: kms_pipe_b_c_ivb results: parsing output: 9/ for test: drm_read results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_async_flips results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_psr results: parsing output: 15/ for test: gem_ppgtt results: parsing output: 16/ for test: gem_exec_alignment results: parsing output: 17/ for test: gen9_exec_parse results: parsing output: 18/ for test: kms_dp_linktrain_fallback results: parsing output: 19/ for test: kms_vblank results: parsing output: 20/ for test: gem_mmap_wc results: parsing output: 21/ for test: kms_psr2_sf results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_flip results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_big_fb 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_frontbuffer_tracking results: parsing output: 29/ for test: gem_exec_reloc results: parsing output: 30/ for test: gem_softpin results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_exec_schedule results: parsing output: 33/ for test: kms_flip results: parsing output: 34/ for test: syncobj_timeline results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: kms_addfb_basic results: parsing output: 37/ for test: syncobj_wait results: parsing output: 38/ for test: kms_selftest results: parsing output: 39/ for test: kms_async_flips results: parsing output: 40/ for test: kms_ccs results: parsing output: 41/ for test: kms_content_protection results: parsing output: 42/ for test: kms_joiner results: parsing output: 43/ for test: gem_workarounds results: parsing output: 44/ for test: gem_partial_pwrite_pread results: parsing output: 45/ for test: gem_render_copy results: parsing output: 46/ for test: i915_query results: parsing output: 47/ for test: kms_cursor_crc results: parsing output: 48/ for test: syncobj_wait results: parsing output: 49/ for test: gem_madvise results: parsing output: 50/ for test: prime_vgem results: parsing output: 51/ for test: kms_flip results: parsing output: 52/ for test: gem_userptr_blits results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: gem_partial_pwrite_pread results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: gem_caching results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_exec_async results: parsing output: 60/ for test: i915_drm_fdinfo results: parsing output: 61/ for test: gem_ccs results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_color results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: kms_getfb results: parsing output: 67/ for test: gem_vm_create results: parsing output: 68/ for test: gem_mmap_offset results: parsing output: 69/ for test: syncobj_timeline results: parsing output: 70/ for test: kms_lease results: parsing output: 71/ for test: kms_flip_scaled_crc results: parsing output: 72/ for test: sysfs_preempt_timeout results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: gem_lmem_swapping results: parsing output: 77/ for test: kms_cursor_legacy results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_chamelium_frames results: parsing output: 80/ for test: gem_pxp results: parsing output: 81/ for test: kms_plane_alpha_blend results: parsing output: 82/ for test: gem_exec_flush results: parsing output: 83/ for test: api_intel_allocator results: parsing output: 84/ for test: gem_ringfill results: parsing output: 85/ for test: kms_atomic_transition results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: syncobj_wait results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_create results: parsing output: 91/ for test: kms_atomic_transition results: parsing output: 92/ for test: prime_vgem results: parsing output: 93/ for test: kms_flip_scaled_crc results: parsing output: 94/ for test: kms_ccs results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_exec_capture results: parsing output: 97/ for test: kms_plane_scaling results: parsing output: 98/ for test: gem_exec_whisper results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_exec_fence results: parsing output: 102/ for test: kms_psr2_sf results: parsing output: 103/ for test: kms_ccs results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: syncobj_wait results: parsing output: 107/ for test: kms_chamelium_color results: parsing output: 108/ for test: syncobj_timeline results: parsing output: 109/ for test: kms_chamelium_hpd results: parsing output: 110/ for test: vgem_basic results: parsing output: 111/ for test: prime_busy results: parsing output: 112/ for test: gem_ctx_persistence results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_dsc results: parsing output: 115/ for test: gem_exec_schedule results: parsing output: 116/ for test: core_getstats results: parsing output: 117/ for test: gem_eio results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_vblank results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: kms_cursor_crc results: parsing output: 122/ for test: gem_ctx_param results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: i915_pm_rpm results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_plane_scaling results: parsing output: 127/ for test: gem_ctx_isolation results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: perf_pmu results: parsing output: 130/ for test: i915_module_load results: parsing output: 131/ for test: gem_pread Done.