[55.822358] Initializing watchdogs [55.822402] /dev/watchdog0 [55.836023] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [55.840068] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.842171] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.845253] [001/133] (960s left) kms_psr (fbc-psr2-sprite-blt) [55.957637] Starting subtest: fbc-psr2-sprite-blt [55.959841] Starting dynamic subtest: eDP-1 [55.964191] Dynamic subtest eDP-1: SKIP (0.000s) [55.968530] Subtest fbc-psr2-sprite-blt: SKIP (0.000s) [56.033165] [002/133] (960s left) kms_vblank (ts-continuation-modeset-rpm) [56.126135] Starting subtest: ts-continuation-modeset-rpm [56.128468] Starting dynamic subtest: pipe-A-eDP-1 [58.631662] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s) [58.650098] Starting dynamic subtest: pipe-D-eDP-1 [60.868322] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.236s) [60.870409] Subtest ts-continuation-modeset-rpm: SUCCESS (4.741s) [61.750916] [003/133] (954s left) gem_exec_balancer (parallel) [62.010583] Starting subtest: parallel [62.883762] Subtest parallel: SUCCESS (0.873s) [63.956192] [004/133] (952s left) gem_exec_fence (syncobj-timeline-wait) [64.500220] Starting subtest: syncobj-timeline-wait [66.001913] Subtest syncobj-timeline-wait: SUCCESS (1.501s) [66.259569] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true [66.263127] [005/133] (950s left) kms_chamelium_color (ctm-negative) [66.356574] Subtest ctm-negative: SKIP (0.000s) [66.407731] [006/133] (950s left) drm_read (short-buffer-nonblock) [66.589276] Starting subtest: short-buffer-nonblock [66.591745] Subtest short-buffer-nonblock: SUCCESS (0.000s) [66.757710] [007/133] (949s left) gem_mmap_gtt (big-bo-tiledx) [66.819283] Subtest big-bo-tiledX: SKIP (0.000s) [66.881869] [008/133] (949s left) i915_query (query-topology-known-pci-ids) [66.927967] Starting subtest: query-topology-known-pci-ids [66.932290] Subtest query-topology-known-pci-ids: SKIP (0.000s) [67.041107] [009/133] (949s left) kms_properties (crtc-properties-legacy) [67.128798] Starting subtest: crtc-properties-legacy [67.130849] Starting dynamic subtest: pipe-A-eDP-1 [67.562161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s) [67.570611] Starting dynamic subtest: pipe-B-eDP-1 [68.698960] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s) [68.709864] Starting dynamic subtest: pipe-C-eDP-1 [69.818623] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s) [69.827780] Starting dynamic subtest: pipe-D-eDP-1 [70.938867] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s) [70.941188] Subtest crtc-properties-legacy: SUCCESS (3.812s) [71.792215] [010/133] (944s left) kms_pm_dc (dc6-dpms) [72.913427] Starting subtest: dc6-dpms [75.035995] Subtest dc6-dpms: SUCCESS (2.121s) [75.118311] [011/133] (941s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [75.228923] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [75.231325] Starting dynamic subtest: pipe-A-eDP-1 [75.254343] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [75.263533] Starting dynamic subtest: pipe-B-eDP-1 [75.285033] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [75.291602] Starting dynamic subtest: pipe-C-eDP-1 [75.312988] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [75.319611] Starting dynamic subtest: pipe-D-eDP-1 [75.341766] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [75.345905] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s) [77.498685] [012/133] (939s left) gem_exec_fence (syncobj-import) [77.902048] Starting subtest: syncobj-import [77.906515] Subtest syncobj-import: SUCCESS (0.006s) [79.005072] [013/133] (937s left) template (b) [79.071895] Starting subtest: B [79.074373] Subtest B: SUCCESS (0.000s) [79.197154] [014/133] (937s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [79.291717] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [79.294019] Starting dynamic subtest: pipe-A-default-mode [79.593212] Dynamic subtest pipe-A-default-mode: SKIP (0.300s) [79.597804] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.301s) [80.432105] [015/133] (936s left) kms_chamelium_edid (dp-mode-timings) [80.829130] Subtest dp-mode-timings: SKIP (0.000s) [81.615557] [016/133] (935s left) kms_big_fb (y-tiled-32bpp-rotate-90) [81.724878] Starting subtest: y-tiled-32bpp-rotate-90 [81.729421] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [81.860944] [017/133] (935s left) kms_colorop (plane-xr30-xr30-srgb_inv_eotf_lut-srgb_eotf_lut) [82.003588] Subtest plane-XR30-XR30-srgb_inv_eotf_lut-srgb_eotf_lut: SKIP (0.000s) [82.094019] [018/133] (934s left) perf (low-oa-exponent-permissions) [82.210825] Starting subtest: low-oa-exponent-permissions [82.248380] Subtest low-oa-exponent-permissions: SUCCESS (0.039s) [82.296698] [019/133] (934s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [87.326811] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [87.329758] Starting dynamic subtest: pipe-A-eDP-1 [99.343632] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.015s) [99.351176] Starting dynamic subtest: pipe-B-eDP-1 [111.388940] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.043s) [111.391329] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.062s) [112.255238] [020/133] (904s left) gem_mmap_gtt (fault-concurrent) [112.310693] Subtest fault-concurrent: SKIP (0.000s) [112.363448] [021/133] (904s left) kms_psr (psr2-primary-mmap-cpu) [112.450073] Starting subtest: psr2-primary-mmap-cpu [112.452441] Starting dynamic subtest: eDP-1 [114.145231] Dynamic subtest eDP-1: SUCCESS (1.696s) [114.147650] Subtest psr2-primary-mmap-cpu: SUCCESS (1.697s) [115.035587] [022/133] (902s left) kms_dirtyfb (default-dirtyfb-ioctl) [115.130742] Starting subtest: default-dirtyfb-ioctl [115.133043] Starting dynamic subtest: A-eDP-1 [116.723790] Dynamic subtest A-eDP-1: SUCCESS (1.591s) [116.725969] Subtest default-dirtyfb-ioctl: SUCCESS (1.592s) [117.565972] [023/133] (899s left) perf_pmu (invalid-open) [117.603690] Starting subtest: invalid-open [117.606054] Subtest invalid-open: SUCCESS (0.000s) [117.744103] [024/133] (899s left) sw_sync (alloc_fence) [117.775820] Starting subtest: alloc_fence [117.777942] Subtest alloc_fence: SUCCESS (0.000s) [117.853738] [025/133] (899s left) i915_hangman (engine-engine-hang) [117.917371] Starting subtest: engine-engine-hang [117.919535] Starting dynamic subtest: rcs0 [119.861306] Dynamic subtest rcs0: SUCCESS (1.943s) [119.870828] Starting dynamic subtest: bcs0 [121.909071] Dynamic subtest bcs0: SUCCESS (2.045s) [121.919883] Starting dynamic subtest: vcs0 [123.892864] Dynamic subtest vcs0: SUCCESS (1.983s) [123.901333] Starting dynamic subtest: vcs1 [125.811831] Dynamic subtest vcs1: SUCCESS (1.917s) [125.822691] Starting dynamic subtest: vecs0 [126.899834] Dynamic subtest vecs0: SUCCESS (1.086s) [126.910197] Starting dynamic subtest: ccs0 [128.885067] Dynamic subtest ccs0: SUCCESS (1.983s) [128.888223] Subtest engine-engine-hang: SUCCESS (10.968s) [128.976291] [026/133] (888s left) gem_softpin (noreloc-s3) [129.036518] Starting subtest: noreloc-S3 [149.140286] Subtest noreloc-S3: SUCCESS (5.402s) [149.307167] [027/133] (868s left) gem_tiling_max_stride [149.449499] [028/133] (867s left) gem_mmap (basic) [149.520289] Subtest basic: SKIP (0.000s) [149.583653] [029/133] (867s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [149.639536] Starting subtest: multi-wait-all-for-submit-available-signaled [149.641871] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [149.766642] [030/133] (867s left) kms_pipe_crc_basic (suspend-read-crc) [149.872410] Starting subtest: suspend-read-crc [149.874304] Starting dynamic subtest: pipe-A-eDP-1 [168.036842] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.555s) [168.051057] Starting dynamic subtest: pipe-B-eDP-1 [185.713054] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.898s) [185.722644] Starting dynamic subtest: pipe-C-eDP-1 [203.666976] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.684s) [203.675442] Starting dynamic subtest: pipe-D-eDP-1 [221.689948] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s) [221.692177] Subtest suspend-read-crc: SUCCESS (10.912s) [222.526962] [031/133] (795s left) kms_prop_blob (blob-prop-lifetime) [222.577197] Starting subtest: blob-prop-lifetime [222.579678] Subtest blob-prop-lifetime: SUCCESS (0.001s) [222.701948] [032/133] (794s left) syncobj_basic (bad-handle-to-fd) [222.751449] Starting subtest: bad-handle-to-fd [222.753675] Subtest bad-handle-to-fd: SUCCESS (0.000s) [222.848529] [033/133] (794s left) kms_lease (page-flip-implicit-plane) [222.938816] Starting subtest: page-flip-implicit-plane [222.940809] Starting dynamic subtest: pipe-A-eDP-1 [223.434045] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s) [223.444238] Starting dynamic subtest: pipe-B-eDP-1 [224.570134] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.134s) [224.578890] Starting dynamic subtest: pipe-C-eDP-1 [225.686271] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s) [225.696224] Starting dynamic subtest: pipe-D-eDP-1 [226.820053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s) [226.822276] Subtest page-flip-implicit-plane: SUCCESS (3.878s) [227.671300] [034/133] (789s left) gem_exec_reloc (basic-softpin) [227.730105] Subtest basic-softpin: SKIP (0.000s) [227.792900] [035/133] (789s left) i915_pm_rpm (gem-idle) [229.610477] Starting subtest: gem-idle [235.829267] Subtest gem-idle: SUCCESS (6.207s) [236.162290] [036/133] (781s left) kms_lease (atomic-implicit-crtc) [237.475437] Starting subtest: atomic-implicit-crtc [237.477731] Starting dynamic subtest: pipe-A-eDP-1 [237.488759] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [237.497002] Starting dynamic subtest: pipe-B-eDP-1 [237.514892] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [237.523219] Starting dynamic subtest: pipe-C-eDP-1 [237.533812] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s) [237.542217] Starting dynamic subtest: pipe-D-eDP-1 [237.552893] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [237.555079] Subtest atomic-implicit-crtc: SUCCESS (0.035s) [237.646019] [037/133] (780s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [237.748404] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [238.517248] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.770s) [238.746439] [038/133] (779s left) gem_exec_whisper (basic-contexts-forked-all) [238.819531] Starting subtest: basic-contexts-forked-all [257.471384] Subtest basic-contexts-forked-all: SUCCESS (18.589s) [257.628031] [039/133] (760s left) kms_flip_tiling (flip-change-tiling) [257.732470] Starting subtest: flip-change-tiling [257.734549] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [257.914916] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.184s) [257.927049] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [258.060772] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.143s) [258.071529] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [258.205198] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s) [258.220282] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [258.359779] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.154s) [258.369686] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [258.503943] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s) [258.518741] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [258.648370] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [258.659105] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [258.782436] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s) [258.798477] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [258.904920] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.121s) [258.917205] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [259.049895] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s) [259.061111] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [259.194570] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [259.205895] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [259.337637] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [259.349773] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [259.482622] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s) [259.494832] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [259.626834] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s) [259.638846] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [259.772435] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s) [259.782315] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [259.893980] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s) [259.906129] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [260.041123] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s) [260.051264] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [260.182389] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [260.192796] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [260.327060] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s) [260.338980] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [260.471970] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [260.483674] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [260.617025] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s) [260.627426] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [260.761015] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [260.772761] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [260.882997] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s) [260.893710] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [261.026861] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.144s) [261.039046] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [261.171879] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.143s) [261.186903] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [261.316013] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s) [261.327704] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [261.461329] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s) [261.473302] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [261.605109] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [261.617122] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [261.749603] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.143s) [261.761017] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [261.882632] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.132s) [261.894101] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [262.028742] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s) [262.040844] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [262.171774] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [262.182804] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [262.316675] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s) [262.328491] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [262.472562] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.154s) [262.483003] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [262.627599] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.154s) [262.639267] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [262.783732] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.154s) [262.799011] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [262.916939] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.132s) [262.971344] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [264.224743] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.260s) [264.237257] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [264.370726] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.143s) [264.382026] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [264.515124] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [264.526968] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [264.658340] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s) [264.670610] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [264.802971] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [264.814659] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [264.947335] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [264.962969] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [265.091577] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.143s) [265.107756] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [265.214128] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s) [265.226172] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [265.348531] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s) [265.360702] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [265.532513] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.182s) [265.548732] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [265.675321] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s) [265.691042] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [265.832018] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.154s) [265.842527] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [265.975484] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s) [265.991489] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [266.121797] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.143s) [266.133797] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [266.242929] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s) [266.254903] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [266.387228] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s) [266.402948] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [266.531375] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [266.543341] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [266.687073] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.154s) [266.697757] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [266.832202] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s) [266.846458] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [266.987867] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.152s) [267.000962] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [267.131795] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [267.146759] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [267.265113] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.132s) [267.275014] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [267.420449] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.154s) [267.432166] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [267.575754] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.154s) [267.590333] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [267.720301] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [267.731748] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [267.864876] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s) [267.876823] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [268.009723] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s) [268.024057] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [268.165633] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.154s) [268.177637] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [268.299176] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.131s) [268.314455] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [268.443533] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [268.455674] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [268.587576] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s) [268.599650] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [268.732644] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s) [268.744573] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [268.876534] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [268.887759] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [269.021095] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s) [269.036233] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [269.202799] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.179s) [269.214412] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [269.324479] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s) [269.378731] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [270.570143] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.199s) [270.585653] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [270.681007] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [270.691829] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [270.792391] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [270.804631] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [270.903232] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [270.912760] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [271.013939] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [271.023961] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [271.125080] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s) [271.136652] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [271.225483] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s) [271.237603] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [271.325853] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s) [271.338014] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [271.437287] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.110s) [271.449141] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [271.547261] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [271.562799] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [271.697173] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.148s) [271.708115] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [271.808191] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [271.819246] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [271.919407] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.110s) [271.931096] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [272.031103] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.109s) [272.043093] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [272.142364] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s) [272.152957] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [272.253129] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [272.265274] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [272.363988] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [272.374936] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [272.475147] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s) [272.486115] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [272.587110] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s) [272.597329] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [272.697906] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [272.708117] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [272.808698] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [272.823115] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [272.920013] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s) [272.930335] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [273.069950] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.148s) [273.079364] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [273.223590] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.152s) [273.233897] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [273.334941] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s) [273.346543] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [273.446186] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [273.457770] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [273.557004] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s) [273.568848] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [273.668294] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s) [273.679516] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [273.779424] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s) [273.793974] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [273.902028] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.121s) [273.917274] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [274.012871] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [274.024076] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [274.123936] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s) [274.133377] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [274.235271] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [274.246603] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [274.346417] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s) [274.356380] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [274.458079] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s) [274.469121] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [274.569474] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s) [274.610327] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [275.799058] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.195s) [275.810626] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [275.910288] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [275.921913] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [276.009975] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s) [276.020234] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [276.160224] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.148s) [276.171631] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [276.271257] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.108s) [276.282192] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [276.382577] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [276.393854] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [276.481607] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [276.493402] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [276.582443] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [276.594963] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [276.682616] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s) [276.694301] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [276.793022] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s) [276.804581] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [276.903983] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [276.915575] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [277.015434] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [277.027111] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [277.115332] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [277.126779] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [277.215607] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [277.227474] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [277.315838] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [277.327271] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [277.426658] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s) [277.438204] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [277.537585] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [277.547744] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [277.648767] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [277.658546] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [277.760168] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s) [277.772379] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [277.871956] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [277.883829] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [277.982899] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [277.994596] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [278.094078] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [278.106112] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [278.204605] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [278.216222] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [278.315749] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s) [278.324794] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [278.426996] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s) [278.438578] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [278.538388] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s) [278.549428] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [278.649392] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [278.662342] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [278.760654] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s) [278.771018] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [278.871726] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s) [278.883825] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [278.983166] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s) [278.998608] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [279.094006] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [279.105039] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [279.205152] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [279.217595] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [279.316131] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [279.327144] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [279.427594] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s) [279.439573] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [279.538804] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s) [279.549382] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [279.650357] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [279.682992] Subtest flip-change-tiling: SUCCESS (21.942s) [280.901025] [040/133] (737s left) kms_flip (dpms-vs-vblank-race) [281.000704] Starting subtest: dpms-vs-vblank-race [281.002971] Starting dynamic subtest: A-eDP1 [285.977360] Dynamic subtest A-eDP1: SUCCESS (4.971s) [285.986871] Starting dynamic subtest: B-eDP1 [290.592412] Dynamic subtest B-eDP1: SUCCESS (4.611s) [290.601741] Starting dynamic subtest: C-eDP1 [295.217319] Dynamic subtest C-eDP1: SUCCESS (4.621s) [295.229370] Starting dynamic subtest: D-eDP1 [299.773967] Dynamic subtest D-eDP1: SUCCESS (4.554s) [299.776372] Subtest dpms-vs-vblank-race: SUCCESS (18.764s) [300.668939] [041/133] (717s left) gem_pipe_control_store_loop (fresh-buffer) [300.721990] Starting subtest: fresh-buffer [302.929306] Subtest fresh-buffer: SUCCESS (2.152s) [303.037898] [042/133] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [303.142663] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [303.146644] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [303.265738] [043/133] (714s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [303.364158] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [309.898398] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.533s) [310.032160] [044/133] (708s left) kms_async_flips (invalid-async-flip) [310.120843] Starting subtest: invalid-async-flip [310.492468] Starting dynamic subtest: pipe-A-eDP-1 [311.814276] Dynamic subtest pipe-A-eDP-1: FAIL (0.762s) [311.825321] Starting dynamic subtest: pipe-B-eDP-1 [312.715371] Dynamic subtest pipe-B-eDP-1: FAIL (0.754s) [312.742244] Starting dynamic subtest: pipe-C-eDP-1 [313.518578] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.783s) [313.878344] Starting dynamic subtest: pipe-D-eDP-1 [314.650442] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.783s) [314.652815] Subtest invalid-async-flip: FAIL (4.529s) [315.814556] [045/133] (702s left) kms_getfb (getfb2-handle-closed) [315.904617] Starting subtest: getfb2-handle-closed [315.906922] Subtest getfb2-handle-closed: SUCCESS (0.000s) [316.028107] [046/133] (702s left) gem_userptr_blits (set-cache-level) [316.092429] Starting subtest: set-cache-level [316.096569] Subtest set-cache-level: SKIP (0.000s) [316.238210] [047/133] (701s left) kms_feature_discovery (display-2x) [316.342408] Starting subtest: display-2x [316.346852] Subtest display-2x: SKIP (0.000s) [316.440425] [048/133] (701s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [321.491718] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [321.496279] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [322.362313] [049/133] (695s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [322.450827] Starting subtest: extended-modeset-hang-oldfb-with-reset [322.453167] Starting dynamic subtest: pipe-A [334.418193] Dynamic subtest pipe-A: SUCCESS (11.974s) [334.429336] Starting dynamic subtest: pipe-D [346.894974] Dynamic subtest pipe-D: SUCCESS (12.477s) [346.897322] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.455s) [347.719437] [050/133] (670s left) gem_busy (close-race) [347.777329] Starting subtest: close-race [371.495553] Subtest close-race: SUCCESS (23.719s) [371.903307] [051/133] (646s left) kms_vrr (flip-suspend) [372.055667] Starting subtest: flip-suspend [372.062387] Subtest flip-suspend: SKIP (0.000s) [372.149005] [052/133] (646s left) gem_pxp (create-regular-context-2) [372.278267] Starting subtest: create-regular-context-2 [372.281032] Subtest create-regular-context-2: SUCCESS (0.002s) [372.402544] [053/133] (646s left) kms_async_flips (async-flip-with-page-flip-events-linear) [372.488377] Starting subtest: async-flip-with-page-flip-events-linear [372.853353] Starting dynamic subtest: pipe-A-eDP-1 [374.145384] Dynamic subtest pipe-A-eDP-1: FAIL (0.830s) [374.157028] Starting dynamic subtest: pipe-B-eDP-1 [375.068318] Dynamic subtest pipe-B-eDP-1: FAIL (0.752s) [375.185027] Starting dynamic subtest: pipe-C-eDP-1 [377.971454] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.740s) [378.301148] Starting dynamic subtest: pipe-D-eDP-1 [381.048224] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.756s) [381.050660] Subtest async-flip-with-page-flip-events-linear: FAIL (8.560s) [382.263986] [054/133] (636s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [382.387134] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [389.655291] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.269s) [389.805798] [055/133] (628s left) gem_ctx_persistence (heartbeat-many) [389.868064] Starting subtest: heartbeat-many [389.872310] Subtest heartbeat-many: SKIP (0.000s) [390.016382] [056/133] (628s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [390.120965] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [395.350942] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.232s) [396.511347] [057/133] (622s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [396.613263] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [396.617758] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [396.739641] [058/133] (621s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [396.853066] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [428.079266] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.216s) [428.924682] [059/133] (589s left) kms_flip (nonblocking-read) [429.036683] Starting subtest: nonblocking-read [429.038517] Subtest nonblocking-read: SUCCESS (0.000s) [429.155519] [060/133] (589s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [429.269364] Starting subtest: basic-flip-before-cursor-varying-size [430.184876] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.913s) [431.064594] [061/133] (587s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [431.166276] Starting subtest: fbc-1p-primscrn-spr-indfb-move [435.458666] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.295s) [436.671801] [062/133] (582s left) sysfs_heartbeat_interval (idempotent) [436.720145] Starting subtest: idempotent [436.722449] Starting dynamic subtest: vecs0 [436.724616] Dynamic subtest vecs0: SUCCESS (0.000s) [436.734812] Starting dynamic subtest: ccs0 [436.736965] Dynamic subtest ccs0: SUCCESS (0.001s) [436.746933] Starting dynamic subtest: vcs0 [436.748848] Dynamic subtest vcs0: SUCCESS (0.000s) [436.758319] Starting dynamic subtest: bcs0 [436.760515] Dynamic subtest bcs0: SUCCESS (0.001s) [436.769986] Starting dynamic subtest: rcs0 [436.772162] Dynamic subtest rcs0: SUCCESS (0.001s) [436.781693] Starting dynamic subtest: vcs1 [436.783804] Dynamic subtest vcs1: SUCCESS (0.000s) [436.785989] Subtest idempotent: SUCCESS (0.007s) [436.823787] [063/133] (582s left) kms_plane (planar-pixel-format-settings) [436.914406] Starting subtest: planar-pixel-format-settings [436.954091] Subtest planar-pixel-format-settings: SUCCESS (0.041s) [437.078157] [064/133] (581s left) gem_ctx_shared (exec-single-timeline) [437.145054] Starting subtest: exec-single-timeline [437.147402] Starting dynamic subtest: rcs0 [438.193821] Dynamic subtest rcs0: SUCCESS (1.046s) [438.207951] Starting dynamic subtest: bcs0 [439.282546] Dynamic subtest bcs0: SUCCESS (1.085s) [439.296128] Starting dynamic subtest: vcs0 [440.370319] Dynamic subtest vcs0: SUCCESS (1.084s) [440.384308] Starting dynamic subtest: vcs1 [441.458553] Dynamic subtest vcs1: SUCCESS (1.084s) [441.472418] Starting dynamic subtest: vecs0 [442.546588] Dynamic subtest vecs0: SUCCESS (1.087s) [442.560121] Starting dynamic subtest: ccs0 [443.634738] Dynamic subtest ccs0: SUCCESS (1.084s) [443.637560] Subtest exec-single-timeline: SUCCESS (6.488s) [443.913322] [065/133] (574s left) gem_userptr_blits (readonly-pwrite-unsync) [443.985418] Subtest readonly-pwrite-unsync: SKIP (0.000s) [444.142457] [066/133] (574s left) kms_color (ctm-negative) [444.245227] Starting subtest: ctm-negative [444.247088] Starting dynamic subtest: pipe-A-eDP-1 [444.961660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [444.973763] Starting dynamic subtest: pipe-B-eDP-1 [446.335996] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s) [446.345582] Starting dynamic subtest: pipe-C-eDP-1 [447.709064] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s) [447.720017] Starting dynamic subtest: pipe-D-eDP-1 [449.051476] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s) [449.054307] Subtest ctm-negative: SUCCESS (4.807s) [449.865008] [067/133] (569s left) syncobj_wait (wait-delayed-signal) [449.926924] Starting subtest: wait-delayed-signal [450.029283] Subtest wait-delayed-signal: SUCCESS (0.103s) [450.128888] [068/133] (568s left) gem_lmem_swapping (heavy-verify-random) [450.168698] Subtest heavy-verify-random: SKIP (0.000s) [450.211960] [069/133] (568s left) kms_cursor_crc (cursor-sliding-32x32) [450.357585] Starting subtest: cursor-sliding-32x32 [450.399143] Subtest cursor-sliding-32x32: SKIP (0.040s) [450.710529] [070/133] (568s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [450.812306] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [450.816726] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [450.947572] [071/133] (568s left) syncobj_wait (wait-all-for-submit-delayed-submit) [450.999744] Starting subtest: wait-all-for-submit-delayed-submit [451.101269] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [451.190158] [072/133] (568s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [451.288668] Starting subtest: psr-rgb101010-draw-pwrite [458.889780] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.605s) [459.016121] [073/133] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [459.112729] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [459.116970] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [459.209184] [074/133] (560s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [459.305746] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [459.310060] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [459.434918] [075/133] (559s left) kms_big_fb (4-tiled-64bpp-rotate-270) [459.533507] Starting subtest: 4-tiled-64bpp-rotate-270 [459.552446] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.018s) [459.688961] [076/133] (559s left) kms_flip (flip-vs-expired-vblank) [459.778344] Starting subtest: flip-vs-expired-vblank [459.780676] Starting dynamic subtest: A-eDP1 [468.503144] Dynamic subtest A-eDP1: SUCCESS (8.693s) [468.515561] Starting dynamic subtest: B-eDP1 [477.226027] Dynamic subtest B-eDP1: SUCCESS (8.722s) [477.238599] Starting dynamic subtest: C-eDP1 [485.876974] Dynamic subtest C-eDP1: SUCCESS (8.639s) [485.889736] Starting dynamic subtest: D-eDP1 [494.470137] Dynamic subtest D-eDP1: SUCCESS (8.637s) [494.475238] Subtest flip-vs-expired-vblank: SUCCESS (34.703s) [495.755689] [077/133] (523s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [495.879352] Starting subtest: cursor-tearing-framebuffer-change [495.881695] Starting dynamic subtest: pipe-A-eDP-1 [496.448796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s) [496.461285] Starting dynamic subtest: pipe-D-eDP-1 [497.654951] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.205s) [497.657198] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.774s) [498.510660] [078/133] (520s left) kms_rmfb (close-fd) [498.618117] Starting subtest: close-fd [498.620458] Starting dynamic subtest: pipe-A-eDP-1 [498.729006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s) [498.740556] Starting dynamic subtest: pipe-B-eDP-1 [499.876118] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s) [499.887343] Starting dynamic subtest: pipe-C-eDP-1 [501.001837] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s) [501.012694] Starting dynamic subtest: pipe-D-eDP-1 [502.125626] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s) [502.127554] Subtest close-fd: SUCCESS (3.507s) [503.357034] [079/133] (516s left) perf_pmu (faulting-read) [503.396259] Starting subtest: faulting-read [503.398548] Starting dynamic subtest: wb [503.400708] Dynamic subtest wb: SUCCESS (0.001s) [503.410242] Starting dynamic subtest: wc [503.412402] Dynamic subtest wc: SUCCESS (0.000s) [503.421679] Starting dynamic subtest: uc [503.423787] Dynamic subtest uc: SUCCESS (0.000s) [503.425958] Subtest faulting-read: SUCCESS (0.003s) [503.524634] [080/133] (516s left) gem_pxp (hw-rejects-pxp-context) [503.587411] Starting subtest: hw-rejects-pxp-context [503.591645] Subtest hw-rejects-pxp-context: SKIP (0.000s) [503.711090] [081/133] (515s left) kms_frontbuffer_tracking (fbc-tiling-linear) [503.807751] Starting subtest: fbc-tiling-linear [507.590268] Subtest fbc-tiling-linear: SUCCESS (3.787s) [508.772897] [082/133] (510s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [509.035795] Starting subtest: parallel-dmabuf-import-out-fence [510.179306] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.144s) [510.290532] [083/133] (509s left) gem_exec_schedule (u-semaphore-codependency) [510.355477] Starting subtest: u-semaphore-codependency [510.361167] Subtest u-semaphore-codependency: SUCCESS (0.012s) [510.732625] [084/133] (508s left) kms_cursor_crc (cursor-random-512x512) [510.991548] Starting subtest: cursor-random-512x512 [510.995910] Subtest cursor-random-512x512: SKIP (0.001s) [511.192909] [085/133] (508s left) i915_query (query-regions-unallocated) [511.249081] Starting subtest: query-regions-unallocated [511.251357] Subtest query-regions-unallocated: SUCCESS (0.000s) [511.372649] [086/133] (508s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [511.480364] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [511.484514] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [511.608798] [087/133] (508s left) kms_psr (pr-cursor-render) [511.691636] Starting subtest: pr-cursor-render [511.695264] Subtest pr-cursor-render: SKIP (0.000s) [511.774379] [088/133] (508s left) kms_big_fb (x-tiled-8bpp-rotate-270) [511.866742] Starting subtest: x-tiled-8bpp-rotate-270 [511.888774] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s) [512.026262] [089/133] (507s left) kms_psr (psr-cursor-mmap-gtt) [512.122045] Starting subtest: psr-cursor-mmap-gtt [512.123967] Starting dynamic subtest: eDP-1 [513.854476] Dynamic subtest eDP-1: SUCCESS (1.731s) [513.857398] Subtest psr-cursor-mmap-gtt: SUCCESS (1.732s) [514.743737] [090/133] (505s left) gen9_exec_parse (valid-registers) [514.807736] Subtest valid-registers: SKIP (0.000s) [514.879926] [091/133] (505s left) gem_mmap (bad-offset) [514.942140] Subtest bad-offset: SKIP (0.000s) [515.011535] [092/133] (504s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [515.101177] Starting subtest: fbcpsr-2p-rte [515.105176] Subtest fbcpsr-2p-rte: SKIP (0.000s) [515.231701] [093/133] (504s left) api_intel_bb (intel-bb-blit-y) [515.292537] Starting subtest: intel-bb-blit-y [519.006611] Subtest intel-bb-blit-y: SUCCESS (3.713s) [519.156731] [094/133] (500s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [519.263542] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [519.267651] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [519.386015] [095/133] (500s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [519.448443] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [519.553541] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s) [519.657624] [096/133] (500s left) gem_ctx_exec (basic-nohangcheck) [519.716885] Starting subtest: basic-nohangcheck [519.962223] Subtest basic-nohangcheck: SUCCESS (0.247s) [520.125834] [097/133] (500s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [520.177415] Starting subtest: yf-tiled-to-vebox-y-tiled [520.182066] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [520.385821] [098/133] (499s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [520.482450] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [521.708482] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.628s) [521.748005] [099/133] (498s left) gem_eio (unwedge-stress) [521.983552] Starting subtest: unwedge-stress [521.985156] Starting dynamic subtest: render [527.109807] Dynamic subtest render: SUCCESS (5.125s) [527.127815] Starting dynamic subtest: bsd1 [549.027469] Dynamic subtest bsd1: SUCCESS (21.913s) [549.045020] Starting dynamic subtest: bsd2 [566.982260] Dynamic subtest bsd2: SUCCESS (17.951s) [566.999141] Starting dynamic subtest: blt [567.003339] Dynamic subtest blt: SKIP (0.000s) [567.013166] Starting dynamic subtest: vebox [588.998926] Dynamic subtest vebox: SUCCESS (22.012s) [589.001254] Subtest unwedge-stress: SUCCESS (67.006s) [590.535734] [100/133] (429s left) syncobj_wait (invalid-wait-illegal-handle) [590.591336] Starting subtest: invalid-wait-illegal-handle [590.593543] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [590.706264] [101/133] (429s left) gem_ctx_engines (execute-oneforall) [590.771922] Starting subtest: execute-oneforall [591.434438] Subtest execute-oneforall: SUCCESS (0.661s) [592.634517] [102/133] (427s left) kms_colorop (plane-xr24-xr24-ctm_3x4_oversaturate) [592.783393] Subtest plane-XR24-XR24-ctm_3x4_oversaturate: SKIP (0.000s) [592.881424] [103/133] (427s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [592.948695] Subtest writes-after-reads-uncached: SKIP (0.000s) [593.029333] [104/133] (427s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [593.132801] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [593.137062] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [593.258232] [105/133] (427s left) kms_cursor_crc (cursor-dpms) [593.379555] Starting subtest: cursor-dpms [593.381777] Starting dynamic subtest: pipe-A-eDP-1 [596.387449] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.006s) [596.398083] Starting dynamic subtest: pipe-D-eDP-1 [599.986229] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.594s) [599.988489] Subtest cursor-dpms: SUCCESS (6.603s) [600.852773] [106/133] (419s left) api_intel_bb (blit-reloc-keep-cache) [600.901872] Starting subtest: blit-reloc-keep-cache [600.906072] Subtest blit-reloc-keep-cache: SKIP (0.000s) [601.057541] [107/133] (419s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [602.580555] Starting subtest: dpms-mode-unset-non-lpsp [603.734690] Subtest dpms-mode-unset-non-lpsp: SKIP (1.154s) [604.124168] [108/133] (416s left) drm_mm (drm_mm) [604.159352] Starting subtest: drm_mm [604.176316] Starting dynamic subtest: drm_test_mm_init [604.303628] Dynamic subtest drm_test_mm_init: SUCCESS (0.125s) [604.315137] Starting dynamic subtest: drm_test_mm_debug [604.419777] Dynamic subtest drm_test_mm_debug: SUCCESS (0.115s) [604.430228] Starting dynamic subtest: drm_test_mm_align32 [604.566022] Dynamic subtest drm_test_mm_align32: SUCCESS (0.147s) [604.575557] Starting dynamic subtest: drm_test_mm_align64 [604.707659] Dynamic subtest drm_test_mm_align64: SUCCESS (0.141s) [604.718711] Starting dynamic subtest: drm_test_mm_lowest [604.811454] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.102s) [604.821018] Starting dynamic subtest: drm_test_mm_highest [604.966584] Dynamic subtest drm_test_mm_highest: SUCCESS (0.152s) [604.968800] Subtest drm_mm: SUCCESS (0.806s) [605.169835] [109/133] (415s left) gem_spin_batch (spin-each) [605.240283] Starting subtest: spin-each [608.596386] Subtest spin-each: SUCCESS (3.358s) [610.581577] [110/133] (410s left) syncobj_timeline (invalid-signal-illegal-handle) [610.636194] Starting subtest: invalid-signal-illegal-handle [610.638516] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [610.761722] [111/133] (410s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [610.867071] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [610.871488] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [610.996977] [112/133] (409s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [611.375136] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [612.208640] [113/133] (408s left) kms_psr (fbc-psr2-cursor-plane-onoff) [612.302655] Starting subtest: fbc-psr2-cursor-plane-onoff [612.304967] Starting dynamic subtest: eDP-1 [612.309250] Dynamic subtest eDP-1: SKIP (0.000s) [612.313744] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [612.388299] [114/133] (408s left) gem_mmap_offset (mmap-boundaries) [612.443978] Starting subtest: mmap-boundaries [612.446155] Starting dynamic subtest: smem0 [612.717972] Dynamic subtest smem0: SUCCESS (0.276s) [612.720549] Subtest mmap-boundaries: SUCCESS (0.277s) [612.892454] [115/133] (408s left) gem_close_race (basic-process) [612.957577] Starting subtest: basic-process [613.026208] Subtest basic-process: SUCCESS (0.071s) [613.234861] [116/133] (407s left) sriov_basic (enable-vfs-autoprobe-on) [613.285571] Starting subtest: enable-vfs-autoprobe-on [613.287806] Starting dynamic subtest: numvfs-1 [613.365964] Dynamic subtest numvfs-1: FAIL (0.004s) [613.377959] Starting dynamic subtest: numvfs-2 [613.453723] Dynamic subtest numvfs-2: FAIL (0.003s) [613.464640] Starting dynamic subtest: numvfs-3 [613.533241] Dynamic subtest numvfs-3: FAIL (0.003s) [613.543002] Starting dynamic subtest: numvfs-4 [613.611362] Dynamic subtest numvfs-4: FAIL (0.003s) [613.621190] Starting dynamic subtest: numvfs-5 [613.694452] Dynamic subtest numvfs-5: FAIL (0.004s) [613.705770] Starting dynamic subtest: numvfs-6 [613.778746] Dynamic subtest numvfs-6: FAIL (0.003s) [613.789828] Starting dynamic subtest: numvfs-7 [613.863439] Dynamic subtest numvfs-7: FAIL (0.003s) [613.874835] Starting dynamic subtest: numvfs-random [613.947975] Dynamic subtest numvfs-random: FAIL (0.003s) [613.959256] Starting dynamic subtest: numvfs-all [614.033060] Dynamic subtest numvfs-all: FAIL (0.511s) [614.035273] Subtest enable-vfs-autoprobe-on: FAIL (0.546s) [614.075070] [117/133] (406s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [614.187089] Starting subtest: basic-flip-before-cursor-legacy [615.103195] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.915s) [615.996483] [118/133] (405s left) core_auth (basic-auth) [616.055205] Starting subtest: basic-auth [616.057242] Subtest basic-auth: SUCCESS (0.001s) [616.163513] [119/133] (404s left) kms_flip (nonexisting-fb) [616.249179] Starting subtest: nonexisting-fb [616.251148] Starting dynamic subtest: A-eDP1 [617.448789] Dynamic subtest A-eDP1: SUCCESS (1.201s) [617.458958] Starting dynamic subtest: B-eDP1 [618.578813] Dynamic subtest B-eDP1: SUCCESS (1.129s) [618.589677] Starting dynamic subtest: C-eDP1 [619.708338] Dynamic subtest C-eDP1: SUCCESS (1.128s) [619.718908] Starting dynamic subtest: D-eDP1 [620.838561] Dynamic subtest D-eDP1: SUCCESS (1.128s) [620.840928] Subtest nonexisting-fb: SUCCESS (4.594s) [622.016538] [120/133] (399s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [622.118785] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [622.121094] Starting dynamic subtest: pipe-A-eDP-1 [622.143369] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [622.154591] Starting dynamic subtest: pipe-B-eDP-1 [622.175555] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [622.184845] Starting dynamic subtest: pipe-C-eDP-1 [622.205453] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [622.214511] Starting dynamic subtest: pipe-D-eDP-1 [622.235712] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [622.240066] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [624.300173] [121/133] (396s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [624.384251] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [624.386557] Starting dynamic subtest: pipe-A-eDP-1 [624.409016] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [624.420992] Starting dynamic subtest: pipe-B-eDP-1 [624.441785] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [624.451546] Starting dynamic subtest: pipe-C-eDP-1 [624.473106] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [624.482803] Starting dynamic subtest: pipe-D-eDP-1 [624.504476] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [624.508520] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s) [626.573290] [122/133] (394s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [626.667937] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [626.670192] Starting dynamic subtest: pipe-A-eDP-1 [626.690152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s) [626.701839] Starting dynamic subtest: pipe-B-eDP-1 [626.721440] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s) [626.732129] Starting dynamic subtest: pipe-C-eDP-1 [626.751878] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [626.761556] Starting dynamic subtest: pipe-D-eDP-1 [626.781435] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s) [626.783618] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.084s) [629.028536] [123/133] (392s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [629.086263] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [629.158584] [124/133] (392s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [629.246305] Starting subtest: fbcpsr-1p-rte [636.230945] Subtest fbcpsr-1p-rte: SUCCESS (6.986s) [636.414204] [125/133] (384s left) kms_scaling_modes (scaling-mode-full-aspect) [636.503513] Starting subtest: scaling-mode-full-aspect [636.505742] Starting dynamic subtest: pipe-A-eDP-1 [636.595940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s) [636.610240] Starting dynamic subtest: pipe-B-eDP-1 [637.768484] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.169s) [637.780451] Starting dynamic subtest: pipe-C-eDP-1 [638.875421] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s) [638.888853] Starting dynamic subtest: pipe-D-eDP-1 [640.011834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [640.014090] Subtest scaling-mode-full-aspect: SUCCESS (3.510s) [641.287313] [126/133] (380s left) gem_exec_schedule (pi-common) [641.470707] Starting subtest: pi-common [641.472972] Starting dynamic subtest: rcs0 [641.495633] Dynamic subtest rcs0: SUCCESS (0.028s) [641.510934] Starting dynamic subtest: bcs0 [641.525558] Dynamic subtest bcs0: SUCCESS (0.029s) [641.539491] Starting dynamic subtest: vcs0 [641.552561] Dynamic subtest vcs0: SUCCESS (0.026s) [641.566902] Starting dynamic subtest: vcs1 [641.579779] Dynamic subtest vcs1: SUCCESS (0.027s) [641.594354] Starting dynamic subtest: vecs0 [641.605609] Dynamic subtest vecs0: SUCCESS (0.025s) [641.620379] Starting dynamic subtest: ccs0 [641.632317] Dynamic subtest ccs0: SUCCESS (0.026s) [641.634568] Subtest pi-common: SUCCESS (0.166s) [641.896416] [127/133] (379s left) gen7_exec_parse (basic-rejected) [641.966660] Subtest basic-rejected: SKIP (0.000s) [642.031839] [128/133] (379s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [642.123292] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [642.125513] Starting dynamic subtest: pipe-A [642.145036] Dynamic subtest pipe-A: SKIP (0.017s) [642.155675] Starting dynamic subtest: pipe-B [642.177559] Dynamic subtest pipe-B: SKIP (0.030s) [642.187924] Starting dynamic subtest: pipe-C [642.205896] Dynamic subtest pipe-C: SKIP (0.030s) [642.216065] Starting dynamic subtest: pipe-D [642.236294] Dynamic subtest pipe-D: SKIP (0.031s) [642.240176] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.111s) [642.380237] [129/133] (379s left) gem_bad_reloc (negative-reloc-lut) [642.434103] Subtest negative-reloc-lut: SKIP (0.000s) [642.503354] [130/133] (379s left) syncobj_timeline (single-wait-available-submitted) [642.556767] Starting subtest: single-wait-available-submitted [642.559079] Subtest single-wait-available-submitted: SUCCESS (0.000s) [642.694925] [131/133] (378s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [642.795824] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [649.753954] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.960s) [649.880093] [132/133] (371s left) gem_partial_pwrite_pread (reads-snoop) [649.934724] Subtest reads-snoop: SKIP (0.000s) [650.007730] [133/133] (371s left) kms_addfb_basic (basic) [650.058024] Starting subtest: basic [650.059946] Subtest basic: SUCCESS (0.000s) [650.219566] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_vblank results: parsing output: 2/ for test: gem_exec_balancer results: parsing output: 3/ for test: gem_exec_fence results: parsing output: 4/ for test: kms_chamelium_color results: parsing output: 5/ for test: drm_read results: parsing output: 6/ for test: gem_mmap_gtt results: parsing output: 7/ for test: i915_query results: parsing output: 8/ for test: kms_properties results: parsing output: 9/ for test: kms_pm_dc results: parsing output: 10/ for test: kms_ccs results: parsing output: 11/ for test: gem_exec_fence results: parsing output: 12/ for test: template results: parsing output: 13/ for test: kms_flip_scaled_crc results: parsing output: 14/ for test: kms_chamelium_edid results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: kms_colorop results: parsing output: 17/ for test: perf results: parsing output: 18/ for test: kms_psr2_sf results: parsing output: 19/ for test: gem_mmap_gtt results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_dirtyfb results: parsing output: 22/ for test: perf_pmu results: parsing output: 23/ for test: sw_sync results: parsing output: 24/ for test: i915_hangman results: parsing output: 25/ for test: gem_softpin results: parsing output: 26/ for test: gem_tiling_max_stride results: parsing output: 27/ for test: gem_mmap results: parsing output: 28/ for test: syncobj_timeline results: parsing output: 29/ for test: kms_pipe_crc_basic results: parsing output: 30/ for test: kms_prop_blob results: parsing output: 31/ for test: syncobj_basic results: parsing output: 32/ for test: kms_lease results: parsing output: 33/ for test: gem_exec_reloc results: parsing output: 34/ for test: i915_pm_rpm results: parsing output: 35/ for test: kms_lease results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: gem_exec_whisper results: parsing output: 38/ for test: kms_flip_tiling results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: gem_pipe_control_store_loop results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_async_flips results: parsing output: 44/ for test: kms_getfb results: parsing output: 45/ for test: gem_userptr_blits results: parsing output: 46/ for test: kms_feature_discovery results: parsing output: 47/ for test: kms_psr2_sf results: parsing output: 48/ for test: kms_busy results: parsing output: 49/ for test: gem_busy results: parsing output: 50/ for test: kms_vrr results: parsing output: 51/ for test: gem_pxp results: parsing output: 52/ for test: kms_async_flips results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_ctx_persistence results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: kms_cursor_legacy results: parsing output: 58/ for test: kms_flip results: parsing output: 59/ for test: kms_cursor_legacy results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: sysfs_heartbeat_interval results: parsing output: 62/ for test: kms_plane results: parsing output: 63/ for test: gem_ctx_shared results: parsing output: 64/ for test: gem_userptr_blits results: parsing output: 65/ for test: kms_color results: parsing output: 66/ for test: syncobj_wait results: parsing output: 67/ for test: gem_lmem_swapping results: parsing output: 68/ for test: kms_cursor_crc results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: syncobj_wait results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_cursor_crc results: parsing output: 77/ for test: kms_rmfb results: parsing output: 78/ for test: perf_pmu results: parsing output: 79/ for test: gem_pxp results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_exec_balancer results: parsing output: 82/ for test: gem_exec_schedule results: parsing output: 83/ for test: kms_cursor_crc results: parsing output: 84/ for test: i915_query results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_psr results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: gen9_exec_parse results: parsing output: 90/ for test: gem_mmap results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: api_intel_bb results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: gem_ctx_exec results: parsing output: 96/ for test: gem_render_copy results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: gem_eio results: parsing output: 99/ for test: syncobj_wait results: parsing output: 100/ for test: gem_ctx_engines results: parsing output: 101/ for test: kms_colorop results: parsing output: 102/ for test: gem_partial_pwrite_pread results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_cursor_crc results: parsing output: 105/ for test: api_intel_bb results: parsing output: 106/ for test: kms_pm_rpm results: parsing output: 107/ for test: drm_mm results: parsing output: 108/ for test: gem_spin_batch results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_chamelium_hpd results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: gem_mmap_offset results: parsing output: 114/ for test: gem_close_race results: parsing output: 115/ for test: sriov_basic results: parsing output: 116/ for test: kms_cursor_legacy results: parsing output: 117/ for test: core_auth results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: kms_ccs results: parsing output: 122/ for test: kms_pipe_b_c_ivb results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_scaling_modes results: parsing output: 125/ for test: gem_exec_schedule results: parsing output: 126/ for test: gen7_exec_parse results: parsing output: 127/ for test: kms_plane_scaling results: parsing output: 128/ for test: gem_bad_reloc results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: gem_partial_pwrite_pread results: parsing output: 132/ for test: kms_addfb_basic Done.